builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-027 starttime: 1468357832.86 results: success (0) buildid: 20160712103020 builduid: 965508eab58744c697c8361b63f23ce7 revision: 94c926911767cbaf285badaccc65b0365ae5bae0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 14:10:32.864539) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 14:10:32.865541) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 14:10:32.865833) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 14:10:32.881616) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 14:10:32.881928) ========= 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=1f5564757af27664ca02d71f000001b0-1468357753.627468-1338201030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-12 14:10:32-- 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% 43.0M=0s 2016-07-12 14:10:33 (43.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093654 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 14:10:32.990129) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 14:10:32.990469) ========= 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=1f5564757af27664ca02d71f000001b0-1468357753.627468-1338201030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021142 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 14:10:33.041218) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 14:10:33.041523) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 94c926911767cbaf285badaccc65b0365ae5bae0 --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 94c926911767cbaf285badaccc65b0365ae5bae0 --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=1f5564757af27664ca02d71f000001b0-1468357753.627468-1338201030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-12 14:10:33,177 truncating revision to first 12 chars 2016-07-12 14:10:33,177 Setting DEBUG logging. 2016-07-12 14:10:33,177 attempt 1/10 2016-07-12 14:10:33,177 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/94c926911767?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-12 14:10:33,491 unpacking tar archive at: mozilla-central-94c926911767/testing/mozharness/ program finished with exit code 0 elapsedTime=0.663607 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 14:10:33.719261) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 14:10:33.719608) ========= script_repo_revision: 94c926911767cbaf285badaccc65b0365ae5bae0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 14:10:33.720088) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 14:10:33.720394) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 14:10:33.731146) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-07-12 14:10:33.731420) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1468357753.627468-1338201030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:10:33 INFO - MultiFileLogger online at 20160712 14:10:33 in /builds/slave/test 14:10:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 14:10:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:10:33 INFO - {'append_to_log': False, 14:10:33 INFO - 'base_work_dir': '/builds/slave/test', 14:10:33 INFO - 'blob_upload_branch': 'Firefox', 14:10:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:10:33 INFO - 'branch': 'Firefox', 14:10:33 INFO - 'buildbot_json_path': 'buildprops.json', 14:10:33 INFO - 'config_files': ('talos/linux_config.py',), 14:10:33 INFO - 'default_actions': ('clobber', 14:10:33 INFO - 'read-buildbot-config', 14:10:33 INFO - 'download-and-extract', 14:10:33 INFO - 'populate-webroot', 14:10:33 INFO - 'create-virtualenv', 14:10:33 INFO - 'install', 14:10:33 INFO - 'run-tests'), 14:10:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:10:33 INFO - 'download_minidump_stackwalk': True, 14:10:33 INFO - 'download_symbols': 'ondemand', 14:10:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:10:33 INFO - 'tooltool.py': '/tools/tooltool.py', 14:10:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:10:33 INFO - '/tools/misc-python/virtualenv.py')}, 14:10:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:10:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:10:33 INFO - 'installer_path': 'installer.exe', 14:10:33 INFO - 'log_level': 'info', 14:10:33 INFO - 'log_name': 'talos', 14:10:33 INFO - 'log_to_console': True, 14:10:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:10:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:10:33 INFO - 'opt_config_files': (), 14:10:33 INFO - 'pip_index': False, 14:10:33 INFO - 'sps_profile': False, 14:10:33 INFO - 'sps_profile_interval': 0, 14:10:33 INFO - 'suite': 'dromaeojs', 14:10:33 INFO - 'system_bits': '32', 14:10:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:10:33 INFO - 'title': 'talos-linux64-ix-027', 14:10:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:10:33 INFO - 'use_talos_json': True, 14:10:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:10:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:10:33 INFO - 'work_dir': 'build'} 14:10:33 INFO - ##### 14:10:33 INFO - ##### Running clobber step. 14:10:33 INFO - ##### 14:10:33 INFO - Running pre-action listener: _resource_record_pre_action 14:10:33 INFO - Running main action method: clobber 14:10:33 INFO - rmtree: /builds/slave/test/build 14:10:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:10:34 INFO - Running post-action listener: _resource_record_post_action 14:10:34 INFO - ##### 14:10:34 INFO - ##### Finished clobber step (success) 14:10:34 INFO - ##### 14:10:34 INFO - ##### 14:10:34 INFO - ##### Running read-buildbot-config step. 14:10:34 INFO - ##### 14:10:34 INFO - Running pre-action listener: _resource_record_pre_action 14:10:34 INFO - Running main action method: read_buildbot_config 14:10:34 INFO - Using buildbot properties: 14:10:34 INFO - { 14:10:34 INFO - "project": "", 14:10:34 INFO - "product": "firefox", 14:10:34 INFO - "script_repo_revision": "production", 14:10:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 14:10:34 INFO - "repository": "", 14:10:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 14:10:34 INFO - "buildid": "20160712103020", 14:10:34 INFO - "pgo_build": "True", 14:10:34 INFO - "basedir": "/builds/slave/test", 14:10:34 INFO - "buildnumber": 795, 14:10:34 INFO - "slavename": "talos-linux64-ix-027", 14:10:34 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:10:34 INFO - "platform": "ubuntu64_hw", 14:10:34 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 14:10:34 INFO - "branch": "mozilla-central", 14:10:34 INFO - "repo_path": "mozilla-central", 14:10:34 INFO - "revision": "94c926911767cbaf285badaccc65b0365ae5bae0", 14:10:34 INFO - "stage_platform": "linux64-pgo", 14:10:34 INFO - "builduid": "965508eab58744c697c8361b63f23ce7", 14:10:34 INFO - "slavebuilddir": "test" 14:10:34 INFO - } 14:10:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/Lt3A8c1mR6OzXEYdSsfjyA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 14:10:34 INFO - Running post-action listener: _resource_record_post_action 14:10:34 INFO - ##### 14:10:34 INFO - ##### Finished read-buildbot-config step (success) 14:10:34 INFO - ##### 14:10:34 INFO - ##### 14:10:34 INFO - ##### Running download-and-extract step. 14:10:34 INFO - ##### 14:10:34 INFO - Running pre-action listener: _resource_record_pre_action 14:10:34 INFO - Running main action method: download_and_extract 14:10:34 INFO - mkdir: /builds/slave/test/build/tests 14:10:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:34 INFO - https://queue.taskcluster.net/v1/task/Lt3A8c1mR6OzXEYdSsfjyA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:10:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lt3A8c1mR6OzXEYdSsfjyA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:10:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lt3A8c1mR6OzXEYdSsfjyA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:10:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lt3A8c1mR6OzXEYdSsfjyA/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 14:10:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lt3A8c1mR6OzXEYdSsfjyA/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 14:10:35 INFO - Downloaded 1361 bytes. 14:10:35 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:10:35 INFO - Using the following test package requirements: 14:10:35 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:10:35 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:10:35 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:10:35 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:35 INFO - u'jsshell-linux-x86_64.zip'], 14:10:35 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:10:35 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:10:35 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:10:35 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:10:35 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:10:35 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:10:35 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:10:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:35 INFO - https://queue.taskcluster.net/v1/task/Lt3A8c1mR6OzXEYdSsfjyA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:10:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lt3A8c1mR6OzXEYdSsfjyA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:10:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lt3A8c1mR6OzXEYdSsfjyA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:10:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lt3A8c1mR6OzXEYdSsfjyA/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 14:10:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lt3A8c1mR6OzXEYdSsfjyA/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 14:10:36 INFO - Downloaded 24270666 bytes. 14:10:36 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'] 14:10:36 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 14:10:37 INFO - Return code: 0 14:10:37 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 14:10: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')]} 14:10:37 INFO - https://queue.taskcluster.net/v1/task/Lt3A8c1mR6OzXEYdSsfjyA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:10:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lt3A8c1mR6OzXEYdSsfjyA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:10:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lt3A8c1mR6OzXEYdSsfjyA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:10:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lt3A8c1mR6OzXEYdSsfjyA/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 14:10:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lt3A8c1mR6OzXEYdSsfjyA/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 14:10:39 INFO - Downloaded 24270666 bytes. 14:10:39 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'] 14:10:39 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 14:10:40 INFO - Return code: 0 14:10:40 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')]} 14:10:40 INFO - https://queue.taskcluster.net/v1/task/Lt3A8c1mR6OzXEYdSsfjyA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:10:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lt3A8c1mR6OzXEYdSsfjyA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:10:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lt3A8c1mR6OzXEYdSsfjyA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:10:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lt3A8c1mR6OzXEYdSsfjyA/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 14:10:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lt3A8c1mR6OzXEYdSsfjyA/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 14:10:41 INFO - Downloaded 14403317 bytes. 14:10:41 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'] 14:10:41 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 14:10:41 INFO - Return code: 0 14:10:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:41 INFO - https://queue.taskcluster.net/v1/task/Lt3A8c1mR6OzXEYdSsfjyA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:10:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lt3A8c1mR6OzXEYdSsfjyA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:10:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lt3A8c1mR6OzXEYdSsfjyA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:10:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lt3A8c1mR6OzXEYdSsfjyA/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 14:10:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lt3A8c1mR6OzXEYdSsfjyA/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 14:10:43 INFO - Downloaded 60484020 bytes. 14:10:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Lt3A8c1mR6OzXEYdSsfjyA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:10:43 INFO - mkdir: /builds/slave/test/properties 14:10:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:10:43 INFO - Writing to file /builds/slave/test/properties/build_url 14:10:43 INFO - Contents: 14:10:43 INFO - build_url:https://queue.taskcluster.net/v1/task/Lt3A8c1mR6OzXEYdSsfjyA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:10:44 INFO - Running post-action listener: _resource_record_post_action 14:10:44 INFO - Running post-action listener: set_extra_try_arguments 14:10:44 INFO - ##### 14:10:44 INFO - ##### Finished download-and-extract step (success) 14:10:44 INFO - ##### 14:10:44 INFO - ##### 14:10:44 INFO - ##### Running populate-webroot step. 14:10:44 INFO - ##### 14:10:44 INFO - Running pre-action listener: _resource_record_pre_action 14:10:44 INFO - Running main action method: populate_webroot 14:10:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:10:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:10:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:10:44 INFO - '--tppagecycles', 14:10:44 INFO - '7'], 14:10:44 INFO - 'tests': ['tsvgm']}}, 14:10:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:10:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:10:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:10:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:10:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:10:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:10:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:44 INFO - 'talos_options': ['--disable-e10s'], 14:10:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:10:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:10:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:44 INFO - 'talos_options': ['--disable-e10s'], 14:10:44 INFO - 'tests': ['damp', 'tps']}, 14:10:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:44 INFO - 'tests': ['damp', 'tps']}, 14:10:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:10:44 INFO - 'tests': ['dromaeo_dom']}, 14:10:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:10:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:10:44 INFO - 'tests': ['basic_compositor_video']}, 14:10:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:10:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:10:44 INFO - 'tests': ['a11yr', 14:10:44 INFO - 'ts_paint', 14:10:44 INFO - 'tpaint', 14:10:44 INFO - 'sessionrestore', 14:10:44 INFO - 'sessionrestore_no_auto_restore', 14:10:44 INFO - 'tabpaint']}, 14:10:44 INFO - 'other-e10s': {'tests': ['a11yr', 14:10:44 INFO - 'ts_paint', 14:10:44 INFO - 'tpaint', 14:10:44 INFO - 'sessionrestore', 14:10:44 INFO - 'sessionrestore_no_auto_restore', 14:10:44 INFO - 'tabpaint']}, 14:10:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:10:44 INFO - 'ts_paint', 14:10:44 INFO - 'tpaint', 14:10:44 INFO - 'sessionrestore', 14:10:44 INFO - 'sessionrestore_no_auto_restore', 14:10:44 INFO - 'tabpaint']}, 14:10:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:10:44 INFO - 'ts_paint', 14:10:44 INFO - 'tpaint', 14:10:44 INFO - 'sessionrestore', 14:10:44 INFO - 'sessionrestore_no_auto_restore', 14:10:44 INFO - 'tabpaint']}, 14:10:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:10:44 INFO - 'tests': ['a11yr', 14:10:44 INFO - 'ts_paint', 14:10:44 INFO - 'tpaint', 14:10:44 INFO - 'sessionrestore', 14:10:44 INFO - 'sessionrestore_no_auto_restore', 14:10:44 INFO - 'tabpaint']}, 14:10:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:10:44 INFO - 'tests': ['a11yr', 14:10:44 INFO - 'ts_paint', 14:10:44 INFO - 'tpaint', 14:10:44 INFO - 'sessionrestore', 14:10:44 INFO - 'sessionrestore_no_auto_restore', 14:10:44 INFO - 'tabpaint']}, 14:10:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:10:44 INFO - 'tests': ['tsvgx', 14:10:44 INFO - 'tsvgr_opacity', 14:10:44 INFO - 'tart', 14:10:44 INFO - 'tscrollx', 14:10:44 INFO - 'cart']}, 14:10:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:10:44 INFO - 'tsvgr_opacity', 14:10:44 INFO - 'tart', 14:10:44 INFO - 'tscrollx', 14:10:44 INFO - 'cart']}, 14:10:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:44 INFO - 'talos_options': ['--disable-e10s'], 14:10:44 INFO - 'tests': ['tp5o']}, 14:10:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:44 INFO - 'tests': ['tp5o']}, 14:10:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:44 INFO - 'talos_options': ['--disable-e10s', 14:10:44 INFO - '--xperf_path', 14:10:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:10:44 INFO - 'tests': ['tp5n']}, 14:10:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:44 INFO - 'talos_options': ['--xperf_path', 14:10:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:10:44 INFO - 'tests': ['tp5n']}}, 14:10:44 INFO - 'talos.zip': {'path': '', 14:10:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:10:44 INFO - Running post-action listener: _resource_record_post_action 14:10:44 INFO - ##### 14:10:44 INFO - ##### Finished populate-webroot step (success) 14:10:44 INFO - ##### 14:10:44 INFO - ##### 14:10:44 INFO - ##### Running create-virtualenv step. 14:10:44 INFO - ##### 14:10:44 INFO - Running pre-action listener: _resource_record_pre_action 14:10:44 INFO - Running main action method: create_virtualenv 14:10:44 INFO - Creating virtualenv /builds/slave/test/build/venv 14:10:44 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 14:10:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:10:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:10:44 INFO - Using real prefix '/usr' 14:10:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:10:44 INFO - Installing distribute.............................................................................................................................................................................................done. 14:10:46 INFO - Installing pip.................done. 14:10:46 INFO - Return code: 0 14:10:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:10:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b66030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e27180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e253b0>, '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 0x1e262b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e26740>, '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': '1f5564757af27664ca02d71f000001b0-1468357753.627468-1338201030', '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 14:10:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:10:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:10:46 INFO - Using env: {'DISPLAY': ':0', 14:10:46 INFO - 'HOME': '/home/cltbld', 14:10:46 INFO - 'LANG': 'en_US.UTF-8', 14:10:46 INFO - 'LANGUAGE': 'en_US:en', 14:10:46 INFO - 'LOGNAME': 'cltbld', 14:10:46 INFO - 'MAIL': '/var/mail/cltbld', 14:10:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:46 INFO - 'MOZ_NO_REMOTE': '1', 14:10:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:46 INFO - 'NO_EM_RESTART': '1', 14:10:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:46 INFO - 'PWD': '/builds/slave/test', 14:10:46 INFO - 'SHELL': '/bin/bash', 14:10:46 INFO - 'SHLVL': '1', 14:10:46 INFO - 'TERM': 'linux', 14:10:46 INFO - 'TMOUT': '86400', 14:10:46 INFO - 'USER': 'cltbld', 14:10:46 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468357753.627468-1338201030', 14:10:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:46 INFO - '_': '/tools/buildbot/bin/python'} 14:10:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:46 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 14:10:46 INFO - Cleaning up... 14:10:47 INFO - Return code: 0 14:10:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:10:47 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')]} 14:10:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:47 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')]} 14:10:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:47 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 0x1b66030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e27180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e253b0>, '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 0x1e262b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e26740>, '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': '1f5564757af27664ca02d71f000001b0-1468357753.627468-1338201030', '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 14:10:47 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 14:10:47 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 14:10:47 INFO - Using env: {'DISPLAY': ':0', 14:10:47 INFO - 'HOME': '/home/cltbld', 14:10:47 INFO - 'LANG': 'en_US.UTF-8', 14:10:47 INFO - 'LANGUAGE': 'en_US:en', 14:10:47 INFO - 'LOGNAME': 'cltbld', 14:10:47 INFO - 'MAIL': '/var/mail/cltbld', 14:10:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:47 INFO - 'MOZ_NO_REMOTE': '1', 14:10:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:47 INFO - 'NO_EM_RESTART': '1', 14:10:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:47 INFO - 'PWD': '/builds/slave/test', 14:10:47 INFO - 'SHELL': '/bin/bash', 14:10:47 INFO - 'SHLVL': '1', 14:10:47 INFO - 'TERM': 'linux', 14:10:47 INFO - 'TMOUT': '86400', 14:10:47 INFO - 'USER': 'cltbld', 14:10:47 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468357753.627468-1338201030', 14:10:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:47 INFO - '_': '/tools/buildbot/bin/python'} 14:10:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:47 INFO - Downloading/unpacking psutil>=3.1.1 14:10:47 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 14:10:47 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 14:10:47 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 14:10:47 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 14:10:47 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 14:10:47 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 14:10:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:10:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:10:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:10:49 INFO - Installing collected packages: psutil 14:10:49 INFO - Running setup.py install for psutil 14:10:49 INFO - building 'psutil._psutil_linux' extension 14:10:49 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 14:10:49 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 14:10:49 INFO - building 'psutil._psutil_posix' extension 14:10:49 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 14:10:49 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 14:10:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:10:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:10:49 INFO - Successfully installed psutil 14:10:49 INFO - Cleaning up... 14:10:49 INFO - Return code: 0 14:10:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:10:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b66030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e27180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e253b0>, '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 0x1e262b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e26740>, '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': '1f5564757af27664ca02d71f000001b0-1468357753.627468-1338201030', '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 14:10:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:10:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:10:49 INFO - Using env: {'DISPLAY': ':0', 14:10:49 INFO - 'HOME': '/home/cltbld', 14:10:49 INFO - 'LANG': 'en_US.UTF-8', 14:10:49 INFO - 'LANGUAGE': 'en_US:en', 14:10:49 INFO - 'LOGNAME': 'cltbld', 14:10:49 INFO - 'MAIL': '/var/mail/cltbld', 14:10:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:49 INFO - 'MOZ_NO_REMOTE': '1', 14:10:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:49 INFO - 'NO_EM_RESTART': '1', 14:10:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:49 INFO - 'PWD': '/builds/slave/test', 14:10:49 INFO - 'SHELL': '/bin/bash', 14:10:49 INFO - 'SHLVL': '1', 14:10:49 INFO - 'TERM': 'linux', 14:10:49 INFO - 'TMOUT': '86400', 14:10:49 INFO - 'USER': 'cltbld', 14:10:49 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468357753.627468-1338201030', 14:10:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:49 INFO - '_': '/tools/buildbot/bin/python'} 14:10:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:10:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:10:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:10:51 INFO - Installing collected packages: mozsystemmonitor 14:10:51 INFO - Running setup.py install for mozsystemmonitor 14:10:52 INFO - Successfully installed mozsystemmonitor 14:10:52 INFO - Cleaning up... 14:10:52 INFO - Return code: 0 14:10:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:10:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:52 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 0x1b66030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e27180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e253b0>, '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 0x1e262b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e26740>, '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': '1f5564757af27664ca02d71f000001b0-1468357753.627468-1338201030', '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 14:10:52 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 14:10:52 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 14:10:52 INFO - Using env: {'DISPLAY': ':0', 14:10:52 INFO - 'HOME': '/home/cltbld', 14:10:52 INFO - 'LANG': 'en_US.UTF-8', 14:10:52 INFO - 'LANGUAGE': 'en_US:en', 14:10:52 INFO - 'LOGNAME': 'cltbld', 14:10:52 INFO - 'MAIL': '/var/mail/cltbld', 14:10:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:52 INFO - 'MOZ_NO_REMOTE': '1', 14:10:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:52 INFO - 'NO_EM_RESTART': '1', 14:10:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:52 INFO - 'PWD': '/builds/slave/test', 14:10:52 INFO - 'SHELL': '/bin/bash', 14:10:52 INFO - 'SHLVL': '1', 14:10:52 INFO - 'TERM': 'linux', 14:10:52 INFO - 'TMOUT': '86400', 14:10:52 INFO - 'USER': 'cltbld', 14:10:52 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468357753.627468-1338201030', 14:10:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:52 INFO - '_': '/tools/buildbot/bin/python'} 14:10:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:52 INFO - Downloading/unpacking jsonschema==2.5.1 14:10:52 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 14:10:52 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 14:10:52 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 14:10:52 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 14:10:52 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 14:10:52 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 14:10:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:10:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:10:54 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 14:10:54 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 14:10:54 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 14:10:54 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 14:10:54 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 14:10:54 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 14:10:54 INFO - Downloading functools32-3.2.3-2.tar.gz 14:10:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:10:54 INFO - warning: no files found matching '*.txt' 14:10:54 INFO - no previously-included directories found matching 'build' 14:10:54 INFO - no previously-included directories found matching 'dist' 14:10:54 INFO - no previously-included directories found matching '.git*' 14:10:54 INFO - Installing collected packages: jsonschema, functools32 14:10:54 INFO - Running setup.py install for functools32 14:10:54 INFO - warning: no files found matching '*.txt' 14:10:54 INFO - no previously-included directories found matching 'build' 14:10:54 INFO - no previously-included directories found matching 'dist' 14:10:54 INFO - no previously-included directories found matching '.git*' 14:10:54 INFO - Successfully installed jsonschema functools32 14:10:54 INFO - Cleaning up... 14:10:54 INFO - Return code: 0 14:10:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:10:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:54 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 0x1b66030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e27180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e253b0>, '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 0x1e262b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e26740>, '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': '1f5564757af27664ca02d71f000001b0-1468357753.627468-1338201030', '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 14:10:54 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 14:10:54 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 14:10:54 INFO - Using env: {'DISPLAY': ':0', 14:10:54 INFO - 'HOME': '/home/cltbld', 14:10:54 INFO - 'LANG': 'en_US.UTF-8', 14:10:54 INFO - 'LANGUAGE': 'en_US:en', 14:10:54 INFO - 'LOGNAME': 'cltbld', 14:10:54 INFO - 'MAIL': '/var/mail/cltbld', 14:10:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:54 INFO - 'MOZ_NO_REMOTE': '1', 14:10:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:54 INFO - 'NO_EM_RESTART': '1', 14:10:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:54 INFO - 'PWD': '/builds/slave/test', 14:10:54 INFO - 'SHELL': '/bin/bash', 14:10:54 INFO - 'SHLVL': '1', 14:10:54 INFO - 'TERM': 'linux', 14:10:54 INFO - 'TMOUT': '86400', 14:10:54 INFO - 'USER': 'cltbld', 14:10:54 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468357753.627468-1338201030', 14:10:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:54 INFO - '_': '/tools/buildbot/bin/python'} 14:10:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:54 INFO - Downloading/unpacking blobuploader==1.2.4 14:10:54 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 14:10:54 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 14:10:54 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 14:10:54 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 14:10:54 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 14:10:54 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 14:10:56 INFO - Downloading blobuploader-1.2.4.tar.gz 14:10:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:10:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:10:56 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 14:10:56 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 14:10:56 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 14:10:56 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 14:10:56 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 14:10:56 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 14:10:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:10:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:57 INFO - Downloading docopt-0.6.1.tar.gz 14:10:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:10:57 INFO - Installing collected packages: blobuploader, requests, docopt 14:10:57 INFO - Running setup.py install for blobuploader 14:10:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:10:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:10:57 INFO - Running setup.py install for requests 14:10:58 INFO - Running setup.py install for docopt 14:10:58 INFO - Successfully installed blobuploader requests docopt 14:10:58 INFO - Cleaning up... 14:10:58 INFO - Return code: 0 14:10:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:58 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 0x1b66030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e27180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e253b0>, '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 0x1e262b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e26740>, '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': '1f5564757af27664ca02d71f000001b0-1468357753.627468-1338201030', '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 14:10:58 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 14:10:58 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 14:10:58 INFO - Using env: {'DISPLAY': ':0', 14:10:58 INFO - 'HOME': '/home/cltbld', 14:10:58 INFO - 'LANG': 'en_US.UTF-8', 14:10:58 INFO - 'LANGUAGE': 'en_US:en', 14:10:58 INFO - 'LOGNAME': 'cltbld', 14:10:58 INFO - 'MAIL': '/var/mail/cltbld', 14:10:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:58 INFO - 'MOZ_NO_REMOTE': '1', 14:10:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:58 INFO - 'NO_EM_RESTART': '1', 14:10:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:58 INFO - 'PWD': '/builds/slave/test', 14:10:58 INFO - 'SHELL': '/bin/bash', 14:10:58 INFO - 'SHLVL': '1', 14:10:58 INFO - 'TERM': 'linux', 14:10:58 INFO - 'TMOUT': '86400', 14:10:58 INFO - 'USER': 'cltbld', 14:10:58 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468357753.627468-1338201030', 14:10:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:58 INFO - '_': '/tools/buildbot/bin/python'} 14:10:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:10:58 INFO - Running setup.py (path:/tmp/pip-EPrKks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:10:58 INFO - Running setup.py (path:/tmp/pip-ZupQGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:10:58 INFO - Running setup.py (path:/tmp/pip-q2A7Vq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:10:58 INFO - Running setup.py (path:/tmp/pip-5iLRpS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:10:58 INFO - Running setup.py (path:/tmp/pip-Ds9DTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:10:58 INFO - Running setup.py (path:/tmp/pip-2oiRyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:10:58 INFO - Running setup.py (path:/tmp/pip-biAblH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:10:58 INFO - Running setup.py (path:/tmp/pip-9JY80Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:10:59 INFO - Running setup.py (path:/tmp/pip-FplZ_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:10:59 INFO - Running setup.py (path:/tmp/pip-cCqDnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:10:59 INFO - Running setup.py (path:/tmp/pip-2tAl5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:10:59 INFO - Running setup.py (path:/tmp/pip-xlj2Li-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:10:59 INFO - Running setup.py (path:/tmp/pip-CEILFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:10:59 INFO - Running setup.py (path:/tmp/pip-FyfgXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:10:59 INFO - Running setup.py (path:/tmp/pip-jRhqoQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:10:59 INFO - Running setup.py (path:/tmp/pip-avk2uR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:10:59 INFO - Running setup.py (path:/tmp/pip-oSLUHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:10:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:10:59 INFO - Running setup.py install for manifestparser 14:10:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:10:59 INFO - Running setup.py install for mozcrash 14:10:59 INFO - Running setup.py install for mozdebug 14:10:59 INFO - Running setup.py install for mozdevice 14:11:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:11:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:11:00 INFO - Running setup.py install for mozfile 14:11:00 INFO - Running setup.py install for mozhttpd 14:11:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:11:00 INFO - Running setup.py install for mozinfo 14:11:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:11:00 INFO - Running setup.py install for mozInstall 14:11:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:11:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:11:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:11:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:11:00 INFO - Running setup.py install for mozleak 14:11:00 INFO - Running setup.py install for mozlog 14:11:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:11:00 INFO - Running setup.py install for moznetwork 14:11:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:11:00 INFO - Running setup.py install for mozprocess 14:11:00 INFO - Running setup.py install for mozprofile 14:11:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:11:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:11:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:11:00 INFO - Running setup.py install for mozrunner 14:11:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:11:01 INFO - Running setup.py install for mozscreenshot 14:11:01 INFO - Running setup.py install for moztest 14:11:01 INFO - Running setup.py install for mozversion 14:11:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:11:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:11:01 INFO - Cleaning up... 14:11:01 INFO - Return code: 0 14:11:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:11:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:01 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 0x1b66030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e27180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e253b0>, '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 0x1e262b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e26740>, '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': '1f5564757af27664ca02d71f000001b0-1468357753.627468-1338201030', '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 14:11:01 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 14:11:01 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 14:11:01 INFO - Using env: {'DISPLAY': ':0', 14:11:01 INFO - 'HOME': '/home/cltbld', 14:11:01 INFO - 'LANG': 'en_US.UTF-8', 14:11:01 INFO - 'LANGUAGE': 'en_US:en', 14:11:01 INFO - 'LOGNAME': 'cltbld', 14:11:01 INFO - 'MAIL': '/var/mail/cltbld', 14:11:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:01 INFO - 'MOZ_NO_REMOTE': '1', 14:11:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:01 INFO - 'NO_EM_RESTART': '1', 14:11:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:01 INFO - 'PWD': '/builds/slave/test', 14:11:01 INFO - 'SHELL': '/bin/bash', 14:11:01 INFO - 'SHLVL': '1', 14:11:01 INFO - 'TERM': 'linux', 14:11:01 INFO - 'TMOUT': '86400', 14:11:01 INFO - 'USER': 'cltbld', 14:11:01 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468357753.627468-1338201030', 14:11:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:01 INFO - '_': '/tools/buildbot/bin/python'} 14:11:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:11:01 INFO - Running setup.py (path:/tmp/pip-onm8Dt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:11:01 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)) 14:11:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:11:01 INFO - Running setup.py (path:/tmp/pip-4M5zOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:11:01 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)) 14:11:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:11:01 INFO - Running setup.py (path:/tmp/pip-1Xbr_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:11:01 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)) 14:11:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:11:01 INFO - Running setup.py (path:/tmp/pip-SiLOM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:11:01 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)) 14:11:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:11:01 INFO - Running setup.py (path:/tmp/pip-Ry7gE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:11:02 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)) 14:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:11:02 INFO - Running setup.py (path:/tmp/pip-uNoiQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:11:02 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)) 14:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:11:02 INFO - Running setup.py (path:/tmp/pip-bpz5vX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:11:02 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)) 14:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:11:02 INFO - Running setup.py (path:/tmp/pip-7jGOT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:11:02 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)) 14:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:11:02 INFO - Running setup.py (path:/tmp/pip-k_3My8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:11:02 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)) 14:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:11:02 INFO - Running setup.py (path:/tmp/pip-gLsJP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:11:02 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)) 14:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:11:02 INFO - Running setup.py (path:/tmp/pip-E14wph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:11:02 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)) 14:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:11:02 INFO - Running setup.py (path:/tmp/pip-AXPPVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:11:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:11:02 INFO - Running setup.py (path:/tmp/pip-eKk_mp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:11:02 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)) 14:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:11:02 INFO - Running setup.py (path:/tmp/pip-yVmi0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:11:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:02 INFO - Running setup.py (path:/tmp/pip-OWas41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:02 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)) 14:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:11:02 INFO - Running setup.py (path:/tmp/pip-O_tytO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:11:02 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)) 14:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:11:02 INFO - Running setup.py (path:/tmp/pip-i10RQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:11:02 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)) 14:11:02 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)) 14:11:02 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)) 14:11:02 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)) 14:11:02 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)) 14:11:02 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)) 14:11:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:11:02 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 14:11:02 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 14:11:02 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 14:11:02 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 14:11:02 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 14:11:02 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 14:11:04 INFO - Downloading blessings-1.6.tar.gz 14:11:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:11:04 INFO - Installing collected packages: blessings 14:11:04 INFO - Running setup.py install for blessings 14:11:04 INFO - Successfully installed blessings 14:11:04 INFO - Cleaning up... 14:11:05 INFO - Return code: 0 14:11:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:11:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:11:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:11:05 INFO - Reading from file tmpfile_stdout 14:11:05 INFO - Current package versions: 14:11:05 INFO - argparse == 1.2.1 14:11:05 INFO - blessings == 1.6 14:11:05 INFO - blobuploader == 1.2.4 14:11:05 INFO - docopt == 0.6.1 14:11:05 INFO - functools32 == 3.2.3-2 14:11:05 INFO - jsonschema == 2.5.1 14:11:05 INFO - manifestparser == 1.1 14:11:05 INFO - mozInstall == 1.12 14:11:05 INFO - mozcrash == 0.17 14:11:05 INFO - mozdebug == 0.1 14:11:05 INFO - mozdevice == 0.48 14:11:05 INFO - mozfile == 1.2 14:11:05 INFO - mozhttpd == 0.7 14:11:05 INFO - mozinfo == 0.9 14:11:05 INFO - mozleak == 0.1 14:11:05 INFO - mozlog == 3.2 14:11:05 INFO - moznetwork == 0.27 14:11:05 INFO - mozprocess == 0.23 14:11:05 INFO - mozprofile == 0.28 14:11:05 INFO - mozrunner == 6.12 14:11:05 INFO - mozscreenshot == 0.1 14:11:05 INFO - mozsystemmonitor == 0.3 14:11:05 INFO - moztest == 0.7 14:11:05 INFO - mozversion == 1.4 14:11:05 INFO - psutil == 3.1.1 14:11:05 INFO - requests == 1.2.3 14:11:05 INFO - wsgiref == 0.1.2 14:11:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:11:05 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')]} 14:11:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:05 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')]} 14:11:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:05 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 0x1b66030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e27180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e253b0>, '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 0x1e262b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e26740>, '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': '1f5564757af27664ca02d71f000001b0-1468357753.627468-1338201030', '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 14:11:05 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 14:11:05 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 14:11:05 INFO - Using env: {'DISPLAY': ':0', 14:11:05 INFO - 'HOME': '/home/cltbld', 14:11:05 INFO - 'LANG': 'en_US.UTF-8', 14:11:05 INFO - 'LANGUAGE': 'en_US:en', 14:11:05 INFO - 'LOGNAME': 'cltbld', 14:11:05 INFO - 'MAIL': '/var/mail/cltbld', 14:11:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:05 INFO - 'MOZ_NO_REMOTE': '1', 14:11:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:05 INFO - 'NO_EM_RESTART': '1', 14:11:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:05 INFO - 'PWD': '/builds/slave/test', 14:11:05 INFO - 'SHELL': '/bin/bash', 14:11:05 INFO - 'SHLVL': '1', 14:11:05 INFO - 'TERM': 'linux', 14:11:05 INFO - 'TMOUT': '86400', 14:11:05 INFO - 'USER': 'cltbld', 14:11:05 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468357753.627468-1338201030', 14:11:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:05 INFO - '_': '/tools/buildbot/bin/python'} 14:11:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:05 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)) 14:11:05 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)) 14:11:05 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)) 14:11:05 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)) 14:11:05 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)) 14:11:05 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)) 14:11:05 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)) 14:11:05 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)) 14:11:05 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)) 14:11:05 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)) 14:11:05 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)) 14:11:05 INFO - Cleaning up... 14:11:05 INFO - Return code: 0 14:11:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:11:05 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')]} 14:11:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:05 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')]} 14:11:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:05 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 0x1b66030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e27180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e253b0>, '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 0x1e262b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e26740>, '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': '1f5564757af27664ca02d71f000001b0-1468357753.627468-1338201030', '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 14:11:05 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 14:11:05 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 14:11:05 INFO - Using env: {'DISPLAY': ':0', 14:11:05 INFO - 'HOME': '/home/cltbld', 14:11:05 INFO - 'LANG': 'en_US.UTF-8', 14:11:05 INFO - 'LANGUAGE': 'en_US:en', 14:11:05 INFO - 'LOGNAME': 'cltbld', 14:11:05 INFO - 'MAIL': '/var/mail/cltbld', 14:11:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:05 INFO - 'MOZ_NO_REMOTE': '1', 14:11:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:05 INFO - 'NO_EM_RESTART': '1', 14:11:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:05 INFO - 'PWD': '/builds/slave/test', 14:11:05 INFO - 'SHELL': '/bin/bash', 14:11:05 INFO - 'SHLVL': '1', 14:11:05 INFO - 'TERM': 'linux', 14:11:05 INFO - 'TMOUT': '86400', 14:11:05 INFO - 'USER': 'cltbld', 14:11:05 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468357753.627468-1338201030', 14:11:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:05 INFO - '_': '/tools/buildbot/bin/python'} 14:11:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:11:05 INFO - Cleaning up... 14:11:05 INFO - Return code: 0 14:11:05 INFO - Running post-action listener: _resource_record_post_action 14:11:05 INFO - Running post-action listener: _start_resource_monitoring 14:11:05 INFO - Starting resource monitoring. 14:11:05 INFO - ##### 14:11:05 INFO - ##### Finished create-virtualenv step (success) 14:11:05 INFO - ##### 14:11:05 INFO - ##### 14:11:05 INFO - ##### Running install step. 14:11:05 INFO - ##### 14:11:05 INFO - Running pre-action listener: _resource_record_pre_action 14:11:05 INFO - Running main action method: install 14:11:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:11:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:11:05 INFO - Reading from file tmpfile_stdout 14:11:05 INFO - Detecting whether we're running mozinstall >=1.0... 14:11:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:11:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:11:06 INFO - Reading from file tmpfile_stdout 14:11:06 INFO - Output received: 14:11:06 INFO - Usage: mozinstall [options] installer 14:11:06 INFO - Options: 14:11:06 INFO - -h, --help show this help message and exit 14:11:06 INFO - -d DEST, --destination=DEST 14:11:06 INFO - Directory to install application into. [default: 14:11:06 INFO - "/builds/slave/test"] 14:11:06 INFO - --app=APP Application being installed. [default: firefox] 14:11:06 INFO - mkdir: /builds/slave/test/build/application 14:11:06 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'] 14:11:06 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 14:11:23 INFO - Reading from file tmpfile_stdout 14:11:23 INFO - Output received: 14:11:23 INFO - /builds/slave/test/build/application/firefox/firefox 14:11:23 INFO - Running post-action listener: _resource_record_post_action 14:11:23 INFO - ##### 14:11:23 INFO - ##### Finished install step (success) 14:11:23 INFO - ##### 14:11:23 INFO - ##### 14:11:23 INFO - ##### Running run-tests step. 14:11:23 INFO - ##### 14:11:23 INFO - Running pre-action listener: _resource_record_pre_action 14:11:23 INFO - Running main action method: run_tests 14:11:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:11:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:11:23 INFO - Python 2.7.3 14:11:23 INFO - Return code: 0 14:11:23 INFO - grabbing minidump binary from tooltool 14:11:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:23 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 0x1e253b0>, '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 0x1e262b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e26740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:11:23 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 14:11:23 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 14:11:23 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 14:11:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:11:23 INFO - Return code: 0 14:11:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:11:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:11:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:11:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:11:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:11:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Lt3A8c1mR6OzXEYdSsfjyA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:11:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Lt3A8c1mR6OzXEYdSsfjyA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:11:23 INFO - Using env: {'DISPLAY': ':0', 14:11:23 INFO - 'HOME': '/home/cltbld', 14:11:23 INFO - 'LANG': 'en_US.UTF-8', 14:11:23 INFO - 'LANGUAGE': 'en_US:en', 14:11:23 INFO - 'LOGNAME': 'cltbld', 14:11:23 INFO - 'MAIL': '/var/mail/cltbld', 14:11:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:11:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:11:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:23 INFO - 'MOZ_NO_REMOTE': '1', 14:11:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:11:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:23 INFO - 'NO_EM_RESTART': '1', 14:11:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:23 INFO - 'PWD': '/builds/slave/test', 14:11:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:11:23 INFO - 'SHELL': '/bin/bash', 14:11:23 INFO - 'SHLVL': '1', 14:11:23 INFO - 'TERM': 'linux', 14:11:23 INFO - 'TMOUT': '86400', 14:11:23 INFO - 'USER': 'cltbld', 14:11:23 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468357753.627468-1338201030', 14:11:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:23 INFO - '_': '/tools/buildbot/bin/python'} 14:11:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Lt3A8c1mR6OzXEYdSsfjyA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:11:24 INFO - mozversion application_buildid: 20160712103020 14:11:24 INFO - mozversion application_changeset: 94c926911767cbaf285badaccc65b0365ae5bae0 14:11:24 INFO - mozversion application_display_name: Nightly 14:11:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:11:24 INFO - mozversion application_name: Firefox 14:11:24 INFO - mozversion application_remotingname: firefox 14:11:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:11:24 INFO - mozversion application_vendor: Mozilla 14:11:24 INFO - mozversion application_version: 50.0a1 14:11:24 INFO - mozversion platform_buildid: 20160712103020 14:11:24 INFO - mozversion platform_changeset: 94c926911767cbaf285badaccc65b0365ae5bae0 14:11:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:11:24 INFO - mozversion platform_version: 50.0a1 14:11:24 INFO - using testdate: 1468357884 14:11:24 INFO - actual date: 1468357884 14:11:24 INFO - starting webserver on 'localhost:39769' 14:11:24 INFO - SUITE-START | Running 2 tests 14:11:24 INFO - TEST-START | dromaeo_css 14:11:24 INFO - operating with platform_type : linux_ 14:11:24 INFO - Initialising browser for dromaeo_css test... 14:11:24 INFO - TEST-INFO | started process 29555 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6DGYqR/profile http://localhost:39769/getInfo.html) 14:11:27 INFO - PROCESS | 29555 | __metrics Screen width/height:1600/1200 14:11:27 INFO - PROCESS | 29555 | colorDepth:24 14:11:27 INFO - PROCESS | 29555 | Browser inner width/height: 1024/697 14:11:27 INFO - PROCESS | 29555 | __metrics 14:11:28 INFO - PROCESS | 29555 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:11:28 INFO - PROCESS | 29555 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:11:29 INFO - TEST-INFO | 29555: exit 0 14:11:29 INFO - Browser initialized. 14:11:29 INFO - Running cycle 1/1 for dromaeo_css test... 14:11:29 INFO - TEST-INFO | started process 29638 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6DGYqR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:11:41 INFO - PROCESS | 29638 | RSS: Main: 156872704 14:11:41 INFO - PROCESS | 29638 | 14:12:32 INFO - PROCESS | 29638 | 1468357952947 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] 14:14:40 INFO - PROCESS | 29638 | Cycle 1(1): loaded http://localhost:39769/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39769/tests/dromaeo/cssquery-ext.html) 14:14:42 INFO - PROCESS | 29638 | RSS: Main: 292376576 14:14:42 INFO - PROCESS | 29638 | 14:17:45 INFO - PROCESS | 29638 | Cycle 1(1): loaded http://localhost:39769/tests/dromaeo/cssquery-ext.html (next: http://localhost:39769/tests/dromaeo/cssquery-jquery.html) 14:17:45 INFO - PROCESS | 29638 | RSS: Main: 237776896 14:17:45 INFO - PROCESS | 29638 | 14:20:47 INFO - PROCESS | 29638 | Cycle 1(1): loaded http://localhost:39769/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39769/tests/dromaeo/cssquery-mootools.html) 14:20:48 INFO - PROCESS | 29638 | RSS: Main: 244391936 14:20:48 INFO - PROCESS | 29638 | 14:23:50 INFO - PROCESS | 29638 | Cycle 1(1): loaded http://localhost:39769/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39769/tests/dromaeo/cssquery-prototype.html) 14:23:50 INFO - PROCESS | 29638 | RSS: Main: 234401792 14:23:50 INFO - PROCESS | 29638 | 14:26:53 INFO - PROCESS | 29638 | Cycle 1(1): loaded http://localhost:39769/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39769/tests/dromaeo/cssquery-yui.html) 14:26:54 INFO - PROCESS | 29638 | RSS: Main: 226971648 14:26:54 INFO - PROCESS | 29638 | 14:29:57 INFO - PROCESS | 29638 | Cycle 1(1): loaded http://localhost:39769/tests/dromaeo/cssquery-yui.html (next: http://localhost:39769/tests/dromaeo/cssquery-dojo.html) 14:29:57 INFO - PROCESS | 29638 | RSS: Main: 270708736 14:29:57 INFO - PROCESS | 29638 | 14:29:57 INFO - PROCESS | 29638 | __start_tp_report 14:29:57 INFO - PROCESS | 29638 | _x_x_mozilla_page_load 14:29:57 INFO - PROCESS | 29638 | _x_x_mozilla_page_load_details 14:29:57 INFO - PROCESS | 29638 | |i|pagename|runs| 14:29:57 INFO - PROCESS | 29638 | |0;dojo.html;2992.9401411971776;3025.2739342557793;3030.696930306968;3098.2409309719114;3148.433282009238;5406.702631355274;5495.120780675093;5528.474794894483;5576.191452239423;5588.8602784930345;5505.449455054492;5554.444555544444;5563.693996830173;5612.214289999393;5672.262605861242;4996.925046124311;5018.021485810268;5018.548330650241;5038.974805125988;5129.769160387791;5093.923591146136;5111.437741848394;5174.586033117342;5220.92168617471;5230.21546767984;4956.603471722254;5125.487451254863;5132.358455193101;5163.561097306733;5188.221766734982;4943.728094954776;4955.1080805455;5004.599632029429;5053.36832895888;5056.924146137811;5014.548690617826;5027.195648696191;5073.2897394364445;5089.567386772129;5136.717480538568;5405.837824865261;5588.608797384185;5602.38373778884;5626.043572592669;5653.943460565424;5781.855453613652;5856.472917437451;5861.6189947653265;5893.852653683693;5904.704764761745;5854.912176317359;5974.193483879664;5989.071693887455;5993.340732519419;5993.951058564734;5453.972730136324;5457.590680698963;5555.833325000256;5568.749406276727;5569.66582005081;6070.119832624333;6108.8884676397665;6110.285381942539;6112.419320164578;6112.480439162632;5885.764569417261;5886.6173698709445;5890.293164820249;5893.705314734246;5897.3807750185615;5735.283089613798;5837.883242335214;5891.23413956183;5982.282126144803;5988.461038506555;5888.852778680482;5889.087191485327;5892.793752218738;5902.911456328158;5932.139839723216;5866.5893387462465;5914.142449344907;5919.378465261172;5919.526437884959;5920.911186332209;4374.912501749947;4434.600885920283;4466.464024317038;4470.932936005963;4507.368968344369;3943.132510847609;3943.408488726714;3954.209158168378;3988.521377434726;3998.4402183694306;5594.1608758686525;5598.1602759586385;5600.131979543095;5606.579506537026;5607.299087614048;5811.883762324815;5878.382769809194;5908.05471124618;5927.881442371128;5975.910361344583;5590.077637189899;5592.86017849557;5603.607747457639;5605.187247849039;5610.831675049755;4916.434610019822;5091.41448733393;5106.412762532282;5111.539961403417;5160.92258616121;5976.850578735566;6054.606450580698;6061.212042434456;6093.146959425684;6096.695165241809;5858.502027327725;5865.677387743715;5873.060310350324;5889.263842019747;5898.056310990392;5899.292084949833;6057.727402266997;6066.18106555627;6074.3014553325165;6075.665838378932;5805.071188609802;5819.854503637443;5825.70871456434;5831.125331200354;5891;5885.676287804212;5899.203607512931;5943;5952.077427998667;5959.046552551571;5614.242077319673;5696;5746.080627099644;5824.417558244142;5829.679367634821;5766.884662306814;5772.393898640582;5781.075027995669;5781.797637082682;5841.18223448726;5704.743286552032;5710.800121995876;5713.285839270091;5714.20001199824;5717.799877004285;5681.744321505459;5786.739596718074;5807.709614519342;5856.531477481876;5858.502027327725;5622.493975542057;5672.4894759471845;5688;5708.80019199326;5745.253117094751 14:29:57 INFO - PROCESS | 29638 | |1;ext.html;582.472862059836;601.7532811547267;619.2228752915091;622.1725105609539;637.7927173668559;42248.788756056216;43738.781306093464;43830.780846095804;43987.78006109965;47396.76301618487;44848.103037939225;45103;45378.54621453785;45384;45423;7902.051753789553;8955.41789783662;9103.499307538083;9104.954475227647;10483.947580262087;10505.737356566071;10842.186835987293;10914.181436392262;10918;10925.235233533616;10874.18443616728;10943.28868623541;10952.945235273812;10955.890441095567;10963.56145754169;8072.959635201816;10665.200109991782;10761.946190269038;10932.617358392497;10969.067629251444;10524;10898.182636302308;10903.182261330352;10903.781924361469;10913.181511386598;33055.83472082648;42158.57841421577;42540.78729606363;42665.14669706619;42773.786131069144;3067.2945222598705;3171.5084161954933;3306.7850589711834;3382.6109997350372;3416.7266618670446;33607.83196084028;33827.661723382946;34075.488867667;34079.829600852085;34126.82936585301;4571.9542804571865;4613.95386046142;4622.976885115587;4641.582257596799;4747.35910652061;368540;370523;372013;372048.1397593022;372429;63132.36867631357;63134;63424.68287658532;63704;63715.36284637095;37012.81493592515;37989.43015854764;38000.23999519994;40037.39943900844;40104;15679.608009799846;15762.527124186292;15780.60548486297;15786.36854525829;15821.367145314058;12548.623541293775;13394.062415630813;13635.113717608323;13703.657408564866;14151.009429340053;20494.487637809176;20816.47958801042;20856.270030548858;20914.686279705817;20991.895040524698;7606.315431611181;7700.884486732703;7763.456558040883;7808;8009.3192078673965;982.4792859784326;1128.9209755317213;1137.5248615479625;1148.488922429511;1167.9708007299716;34015.489767653504;34079;34167.316653666785;34178.829105854806;34387.4841877372;1006.9194464442827;1026.1124127629546;1041.390786389955;1079.4980334144661;1115.6151127861037;17528.47414577539;17585.472435826945;17693.399716073913;17823.46529604114;17866;608545;615509;616175;616228;616489;57665.71167144137;58990;58991;59007.40992590019;59100.40899591035;1217.1358335581658;1231.4704676988802;1333.5799223244646;1367.7674795285025;1378.152436251698;32804.67195328112;35198.82400588083;35281;35358.292834143685;35983.82008090048;55916;57389;57421.71289143527;62843.6857815708;63123.84380780851;523203;535924.883380241;536290;536511;537124;37307.25385492329;42823.143537129705;46364.30453543132;48229;48590.757046214545;49299.7003693119;49372;50397.74801125971;50444.99110017852;50623.74688126536;41236.38145427881;41427.37858932179;42282.36576451294;42414.28132951728;42686.78656606697;41687.374689379074;41824.581754182065;41887;42454.78772606117;42691.57308427;35641.28717425585;36265.27469450543;36491;36564.634353656125;36576.26847463089;28722.081579460366;31416.057518274487;31436.77846201269;31669.683303166672;31834.044978650676;25198.496030079663;25360.619590705785;25697.871510642326;25763;26136.215913522625 14:29:57 INFO - PROCESS | 29638 | |2;jquery.html;388.56868875548145;392.8840991907387;394.026753917823;398.5775078416878;423.45163013897;13666.619054420778;18713.251469941188;18997.620047599055;20553.588928221427;20567.074481648324;15319;16676.249568769403;17424.390146344882;17650.558736031606;17898.37355692551;5585.441455854423;5753.856153596152;5761.366249712528;5768.509676677467;5768.567357448187;5531.529819965288;5572.944270557304;5578.330600327967;5583.637063590853;5586.916196257039;4194.161167766443;4378.6934914555995;4561.361409402686;6305.9684701576425;6331.525135614825;6214.316425193225;6376.649284289362;6423.036544518313;6429.35706429358;6429.678516074201;5600.831975040755;5605.57958153136;5633.521150702195;5651.943480565183;5655.321361436613;21480.570388592296;23156.42108947273;23317;23600.881995590084;23856.284311470685;2456.078970386105;2481.404462928884;2763.9220703925484;2882.2506148401358;2910.9272268193254;9825.508724563815;10084.142847857867;10281.948590257076;12204.450799714034;13525.932370338085;1910.1595298068805;1964.8722833015809;1980.069367397321;1995.1321175288651;2030.6750919852752;85436.57281713614;85731;86214;86977.75258326666;87941.56029219877;10191.796164076677;10239.692809215736;10389.376637401629;10401.68794936153;11443.25618834773;14373.06575072617;14468.27658617065;14468.85531144675;14476;14480;7925.960370198228;8291.751247462586;8322;8342.791430214293;8375.288100511525;8235.21765432283;8243.25810677042;8323.875141872877;8442.873356899652;8517.190866867637;4537.001859590885;4564.246899261585;4576.199165146086;4598.609118224988;4616.146012987608;1828.789689185734;1857.4149143019906;1892.3093071028975;1962.8724132931313;1996.3112726109468;1019.3425240719695;1070.566420599643;1076.7200527862656;1094.6551836171739;1097.91765617579;18966.620667586845;19769.209231630575;19770.20919163246;19879.204831806564;20349.49126271855;1008.2135933971514;1026.4559783314855;1031.4533297352416;1045.7764415633726;1119.171812858479;10667.893321066846;10702.732431689114;11010.614628488125;11073.667789966314;11123.55505779776;374072;377884;494188;498375;501340;59852;69691.65154174298;104425;105158;108020.45989770001;980.9117179453883;1015.8577799108131;1027.5530144387214;1055.8785739639886;1056.6143357674393;17465.82534174642;17613.735793962845;17953;17978.190981405605;18320.17559209812;41179.58820411877;45966;46530.53469465397;46537.301940471596;46711;53079.734601326745;61773.38226617676;62540;63109.36890631035;64310;8468.830623387621;8481.491110533389;8779.824403511766;8873.423227490193;8935.553222338987;8644.827103458021;13302.201867887958;13507.122037067558;13619.659508512366;14292;11238.494267758135;11502.367369794742;11643.12676549279;11784.234024788362;11968.76062478763;11846.11154163424;12061.336626485627;12282.692932676755;12355.814662780245;12562.183458075197;11507.654770356903;11549;11636.53453861836;11715.1799374043;11812.40937953116;8764.561771911507;8771.868421973548;8800.60397282111;9058.411203271766;9224;10523.263371563917;11242.931921467447;11261.49323280438;11263.493142808757;11361 14:29:57 INFO - PROCESS | 29638 | |3;mootools.html;1358.096865584386;1422.7652437347838;1470.21343581184;1711.95272415101;1740.8520275776566;8736.912630873689;9196.954015229914;9272.768180795467;9291.559808229727;9311.441313521193;7445.404367650589;7552.320291173807;7605.543667379961;7814.843703125934;8986.910130898688;2191.145453273221;2256.0862850545554;2269.704938358011;2296.2537175417974;2299.839011269212;2321.3152120124605;2332.288651961151;2354.09367393553;2355.222776483756;2372.9914786215877;1970.980290197101;2245.5396643688086;2353.6116540770754;2362.870042147681;2364.8817559122062;2284.0521183708743;2309.2379514760087;2311.2257393773107;2317.2816426907543;2318.13070098713;2245.2590645087244;2247.1123906057014;2250.932472025842;2255.2444930948154;2268.194790849241;8974.192322690924;9081.59132839024;9083.7274881753;9083.909160908372;9086.863697044484;4933.062718083553;5067.265246539268;5070.72111033893;5074.847754567369;5076.466970968032;3398.7111095556907;3461.913452163691;3540.044188069233;3548.1661809474754;3553.893383198508;1163.4764356039732;1188.7860185166667;1194.6834088966432;1227.1226073357593;1229.7970834812334;13022.934885325607;13026.023048271323;13053.15154514963;13088.47646094155;13099.279539625317;4563.429571303587;4577.931331030038;4670.8365207217585;4705.058988202373;4783;10840.67477975662;10849.349039057683;10853.782924341469;10861.674149775361;10862.837057444145;5247.02929957959;5249.947500525022;5252.763625636855;5253.080710875582;5254.973725131426;4092.6112019358116;4698.060387922429;4837.250226214942;4843.564079232886;4849.684770489906;3987.1626958339075;3996.2207369562657;4105.384192371109;4175.791210439526;4185.183889141649;1278.3033246880473;1298.9480420783063;1300.5708116321591;1312.7768279392526;1315.4803852478408;915.624593916491;945.546137853834;971.9805603887883;975.327024353194;996.1781530237583;6057.636541807506;6124.846878827976;6131.693415329216;6210.937890621036;6288.842778930563;428.00488863392735;431.8833914842975;433.1099590341878;439.8724369932748;448.41257952082225;3944.3491823848744;3987.4218238355274;4012.0972781124015;4032.5160980681917;4083.89790255246;11166.441677916235;11676.591319303783;11755.177137600285;11756;11788.764224715458;11631.825522617168;11639.010684091947;11639.76720465603;11645.010174135294;11651;7864.5281283123195;8203.384746144064;8295.087540370554;8457.323414126855;8578.313734901192;6175.320714721287;6250.187475628321;6278.937210627835;6294.464970477377;6347.936520634919;10539.367637941441;10857.294275872358;10963.451827408757;10966.945165274123;11050.613228537284;10911.181661375269;10956.890431095906;11065.391403472886;11068.889311106786;11083.778324433304;7314.122305323395;7643.082830060428;7751.92248077512;7953.085395179397;8261.13258107914;9069.546522673709;9092.454452732858;9135.2235060018;9161.725148245563;9174.770630734285;7818.648160832662;8080.676772929017;8127.593620319079;8177.795555110932;8228.876566851623;7760.84478310442;7764.611769411394;7905.960470197612;7942.285194332538;8112.675492980215;6862.862742745217;7215.927840721525;7344.742933997284;7397.1863095058425;7413.666385012795;4959.925601115914;4976.328195693535;5024.57291130258;5030.496950304941;5089.8727531812;5152;5255.9211611825085;5258.158694608845;5295.417504074471;5320.388155362183 14:29:57 INFO - PROCESS | 29638 | |4;prototype.html;325.49548200289547;326.13574028823615;335.8774047472672;338.34361339002334;344.83275611328486;5227.26818245445;5400.108982017962;5453.236546883434;5462.972685136579;5494.587905907053;5426.186072089188;5430.59270554708;5433.320834895638;5457;5457.945420545793;4206.390073439357;4217;4217.388478670591;4229.6404805591565;4242.215190189825;4023.356262997921;4141.0744004038115;4245.575442455745;4257.14857028594;4262.616364527192;4172.603602657743;4215.3044747616605;4237.173751118533;4244.493204912258;4272.295071313245;4233.216854881842;4236.5763423657545;4241.448611680462;4254.595813397753;4284.721493102969;3605.405108157151;3757.793321367351;3768.1898391845884;3787.962120378816;3789.9242015159816;5266.4733526647415;5277.815276465305;5299.973500132513;5303.893922121536;5352.491513306269;4823.311840855672;4824.348712923746;4873.34209881665;4891.315215869781;4897.804087836482;5419.295491586068;5602.747876345574;5648.802291919804;5666.376698563155;5712.2574065371655;3985.9636494511346;3998.4801975743258;4000.5199376074765;4008.118213992917;4027;5964.165016897595;5981.790637327673;5987.850303742398;6009.308929473123;6011.609245399035;3962.465067215889;4155.896102597399;4162.500499939966;4164.8542301019925;4165.354370072643;4197.601227883346;4219.945013746564;4224.8732538023905;4229.407882896397;4243.215005224043;4812.374391329105;4832.95167048325;4851.393575803025;4869.14789911764;4883.609311255091;5533.446655334435;5696.857578560569;5699.601027928005;5719.370869204384;5805.332386775491;1382.0740104130257;1425.5652026131922;1425.5865798918198;1442.8268607766925;1448.898577099593;967.3373738988674;974.3910056214866;987.2151639446657;991.6975322526555;998.605550807427;5470.5350045245805;5480.013597552399;5489.505944464938;5494.862628434321;5507.449255074541;5729.7708091676695;5741.971290143606;5773.624714393635;5795.391483894215;5797.826065218051;5251.579873610102;5481.287432633732;5491.670499770026;5511.421300763443;5515.889682206333;2710.587577056382;2730.6586676665415;2732.8547090533834;2733.7129601391966;2759.379139693593;5266.288456251734;5278.736063196825;5279.41926388097;5284.599581111009;5299.4435584263865;5030.423163022796;5126.87182820425;5274.551663108602;5284.154535274338;5288.68267903927;5225.895482090337;5227.9215811763615;5273.947260527422;5324.9733751331;5331.253624492574;4959.578435832995;5113.744312784272;5143.8456846294675;5169.932027189155;5187.636865419385;5068.467810879952;5088.567471764942;5091.319864444798;5103.336566246364;5122.667026643257;5289.259503669412;5301.284326615858;5301.946980530145;5310.742934252849;5343.599230057839;3734.122481216966;3743.2326373092906;3743.850245990239;3809.7333186677774;3826.234753049457;5417.133258678593;5611.719414029364;5770.826875193751;5898.233229680286;5919.733611987384;5622.353429355677;5639.8308050756905;5646.830595082154;5723.170140329712;5760.8271751847515;5687.232223649919;5700.800471983461;5807.577143599845;5835.94164058371;5848.883022339444;5627.662340259434;5645.350784659817;5653.40639232891;5654.434556544313;5695.914561281667;5768.336641286306;5787.974209026976;5801.477866991991;5810.360860305278;5811.94188058114;5505.944940550543;5613;5627.718614069362;5685.800996965087;5740.335302762152 14:29:57 INFO - PROCESS | 29638 | |5;yui.html;715.5134508534198;726.2773540327375;783.9490433121848;808.5027707959599;815.461795215158;13556.593302200938;14290.785638215435;14405.63985900353;14434.85565144347;14436.422543098277;14523.636909077251;14585.124892506457;14607.342669579868;14607.415703371878;14624.415023399051;656.5502630697987;767.4436033875423;777.6811507282016;795.8925545051402;797.3342259213564;799.3844739550542;800.4236949396454;801.6913488307015;801.7955421367573;803.1045384396415;835.3609488741118;836.4939211776879;836.7447928381841;836.8117173635914;838.4340570115178;688.3460712323313;815.229608020421;820.024171236233;823.9876401853977;825.8059356051353;616.2604874151036;616.2974209401286;616.9537284703621;617.1976430640194;617.9752809887599;15112.168830714307;15132.243387830564;15162.241887905671;15182.924085379613;15184.772228416583;14055.78916316256;14457;14516.419343226258;14533.418663253457;14555.70888582233;12787.488500459971;12837.550685726048;12886.097973141885;12899.789964064987;13157;4338.284183109815;4360.258756011485;4372;4482.7310361378095;4557.316402539613;72548.27451725469;72662;73605.26394736038;73911.26088739098;76643.61678191573;11161.172324575105;11175.979983319505;11189;11473.483693233824;11634.243774154653;20923.79076209249;20956.37130886076;21017.89491052535;21021.579568408546;21046;8557.914420855835;8615.526146061902;8637.740867773977;8848.380613357003;9017.549122543847;4794.237761959441;4862.246351815404;4880.365552478155;4898.485659005824;4971.353724015927;3155.2742869140225;3225.048610659861;3227.967720322814;3234.4824828027404;3263.6246831614194;613.4662843326334;645.6215978885114;652.2075678051191;663.6847497438678;664.0935123556311;554.3680204566797;571.7427157778933;630.9305976342598;662.1392190152878;716.6882406153236;9898.80202395948;9990;10061.698149055394;10130.746731331776;10299.330543514647;680.571240118722;698.6611493425685;717.5873872523216;718.4360277182491;739.1340866308662;4818.6626936114835;5014.247862820534;5108.923366149511;5111.642185047085;5112.130937740593;99167;124711;130711.34644326718;133168;134683;72788.63605681938;95209.52395238118;95549.5222523883;96359;96504;52611;53473.46526534763;73887.26112738911;84448.57775711206;84935.575322123;10185.9490702546;10484.266101373136;10602.575896964036;10642.361458312525;10741.355518668592;49005.2649210255;50324.96100467967;50876.745616271684;51375.22937155871;51861.962760743816;67805.66097169483;74361.25638743759;74939.25060749323;76570.61714691391;76636.61681691778;13416.262105584286;13506.392212350664;13536.661583460493;13879.444822207402;14066.929665351608;14068.62524781914;14452.494162704255;14478;14589.343479543659;15838.366465341258;14721.33753981095;14812;14830.703385932005;15545.611359716098;15775.763363549786;14138.717225655635;14139.787903181255;14186.858131418554;14363.425462981782;14747.336369863167;14161.43136406359;14218.928905355408;14779.408823646934;14943.626409339853;15012.47456339023;11460;11516.769664606829;11646.534138634359;11892.345920974429;11901.583444579399;12201.901828835447;12298.262104273772;12306.323152226714;12675.873241267838;12726.427310771223 14:29:57 INFO - PROCESS | 29638 | __end_tp_report 14:29:57 INFO - PROCESS | 29638 | __start_cc_report 14:29:57 INFO - PROCESS | 29638 | _x_x_mozilla_cycle_collect,1115 14:29:57 INFO - PROCESS | 29638 | __end_cc_report 14:29:57 INFO - PROCESS | 29638 | __startTimestamp1468358997270__endTimestamp 14:29:57 INFO - PROCESS | 29638 | 14:29:57 INFO - PROCESS | 29638 | ------- Summary: start ------- 14:29:57 INFO - PROCESS | 29638 | Number of tests: 6 14:29:57 INFO - PROCESS | 29638 | 14:29:57 INFO - PROCESS | 29638 | [#0] dojo.html Cycles:165 Average:5491.30 Median:5708.80 stddev:640.46 (11.2%) stddev-sans-first:611.70 14:29:57 INFO - PROCESS | 29638 | Values: 2992.9 3025.3 3030.7 3098.2 3148.4 5406.7 5495.1 5528.5 5576.2 5588.9 5505.4 5554.4 5563.7 5612.2 5672.3 4996.9 5018.0 5018.5 5039.0 5129.8 5093.9 5111.4 5174.6 5220.9 5230.2 4956.6 5125.5 5132.4 5163.6 5188.2 4943.7 4955.1 5004.6 5053.4 5056.9 5014.5 5027.2 5073.3 5089.6 5136.7 5405.8 5588.6 5602.4 5626.0 5653.9 5781.9 5856.5 5861.6 5893.9 5904.7 5854.9 5974.2 5989.1 5993.3 5994.0 5454.0 5457.6 5555.8 5568.7 5569.7 6070.1 6108.9 6110.3 6112.4 6112.5 5885.8 5886.6 5890.3 5893.7 5897.4 5735.3 5837.9 5891.2 5982.3 5988.5 5888.9 5889.1 5892.8 5902.9 5932.1 5866.6 5914.1 5919.4 5919.5 5920.9 4374.9 4434.6 4466.5 4470.9 4507.4 3943.1 3943.4 3954.2 3988.5 3998.4 5594.2 5598.2 5600.1 5606.6 5607.3 5811.9 5878.4 5908.1 5927.9 5975.9 5590.1 5592.9 5603.6 5605.2 5610.8 4916.4 5091.4 5106.4 5111.5 5160.9 5976.9 6054.6 6061.2 6093.1 6096.7 5858.5 5865.7 5873.1 5889.3 5898.1 5899.3 6057.7 6066.2 6074.3 6075.7 5805.1 5819.9 5825.7 5831.1 5891.0 5885.7 5899.2 5943.0 5952.1 5959.0 5614.2 5696.0 5746.1 5824.4 5829.7 5766.9 5772.4 5781.1 5781.8 5841.2 5704.7 5710.8 5713.3 5714.2 5717.8 5681.7 5786.7 5807.7 5856.5 5858.5 5622.5 5672.5 5688.0 5708.8 5745.3 14:29:57 INFO - PROCESS | 29638 | 14:29:57 INFO - PROCESS | 29638 | [#1] ext.html Cycles:180 Average:66224.22 Median:202776.41 stddev:137523.52 (67.8%) stddev-sans-first:137821.00 14:29:57 INFO - PROCESS | 29638 | Values: 582.5 601.8 619.2 622.2 637.8 42248.8 43738.8 43830.8 43987.8 47396.8 44848.1 45103.0 45378.5 45384.0 45423.0 7902.1 8955.4 9103.5 9105.0 10483.9 10505.7 10842.2 10914.2 10918.0 10925.2 10874.2 10943.3 10952.9 10955.9 10963.6 8073.0 10665.2 10761.9 10932.6 10969.1 10524.0 10898.2 10903.2 10903.8 10913.2 33055.8 42158.6 42540.8 42665.1 42773.8 3067.3 3171.5 3306.8 3382.6 3416.7 33607.8 33827.7 34075.5 34079.8 34126.8 4572.0 4614.0 4623.0 4641.6 4747.4 368540.0 370523.0 372013.0 372048.1 372429.0 63132.4 63134.0 63424.7 63704.0 63715.4 37012.8 37989.4 38000.2 40037.4 40104.0 15679.6 15762.5 15780.6 15786.4 15821.4 12548.6 13394.1 13635.1 13703.7 14151.0 20494.5 20816.5 20856.3 20914.7 20991.9 7606.3 7700.9 7763.5 7808.0 8009.3 982.5 1128.9 1137.5 1148.5 1168.0 34015.5 34079.0 34167.3 34178.8 34387.5 1006.9 1026.1 1041.4 1079.5 1115.6 17528.5 17585.5 17693.4 17823.5 17866.0 608545.0 615509.0 616175.0 616228.0 616489.0 57665.7 58990.0 58991.0 59007.4 59100.4 1217.1 1231.5 1333.6 1367.8 1378.2 32804.7 35198.8 35281.0 35358.3 35983.8 55916.0 57389.0 57421.7 62843.7 63123.8 523203.0 535924.9 536290.0 536511.0 537124.0 37307.3 42823.1 46364.3 48229.0 48590.8 49299.7 49372.0 50397.7 50445.0 50623.7 41236.4 41427.4 42282.4 42414.3 42686.8 41687.4 41824.6 41887.0 42454.8 42691.6 35641.3 36265.3 36491.0 36564.6 36576.3 28722.1 31416.1 31436.8 31669.7 31834.0 25198.5 25360.6 25697.9 25763.0 26136.2 14:29:57 INFO - PROCESS | 29638 | 14:29:57 INFO - PROCESS | 29638 | [#2] jquery.html Cycles:180 Average:28093.86 Median:22318.50 stddev:75164.66 (336.8%) stddev-sans-first:75346.73 14:29:57 INFO - PROCESS | 29638 | Values: 388.6 392.9 394.0 398.6 423.5 13666.6 18713.3 18997.6 20553.6 20567.1 15319.0 16676.2 17424.4 17650.6 17898.4 5585.4 5753.9 5761.4 5768.5 5768.6 5531.5 5572.9 5578.3 5583.6 5586.9 4194.2 4378.7 4561.4 6306.0 6331.5 6214.3 6376.6 6423.0 6429.4 6429.7 5600.8 5605.6 5633.5 5651.9 5655.3 21480.6 23156.4 23317.0 23600.9 23856.3 2456.1 2481.4 2763.9 2882.3 2910.9 9825.5 10084.1 10281.9 12204.5 13525.9 1910.2 1964.9 1980.1 1995.1 2030.7 85436.6 85731.0 86214.0 86977.8 87941.6 10191.8 10239.7 10389.4 10401.7 11443.3 14373.1 14468.3 14468.9 14476.0 14480.0 7926.0 8291.8 8322.0 8342.8 8375.3 8235.2 8243.3 8323.9 8442.9 8517.2 4537.0 4564.2 4576.2 4598.6 4616.1 1828.8 1857.4 1892.3 1962.9 1996.3 1019.3 1070.6 1076.7 1094.7 1097.9 18966.6 19769.2 19770.2 19879.2 20349.5 1008.2 1026.5 1031.5 1045.8 1119.2 10667.9 10702.7 11010.6 11073.7 11123.6 374072.0 377884.0 494188.0 498375.0 501340.0 59852.0 69691.7 104425.0 105158.0 108020.5 980.9 1015.9 1027.6 1055.9 1056.6 17465.8 17613.7 17953.0 17978.2 18320.2 41179.6 45966.0 46530.5 46537.3 46711.0 53079.7 61773.4 62540.0 63109.4 64310.0 8468.8 8481.5 8779.8 8873.4 8935.6 8644.8 13302.2 13507.1 13619.7 14292.0 11238.5 11502.4 11643.1 11784.2 11968.8 11846.1 12061.3 12282.7 12355.8 12562.2 11507.7 11549.0 11636.5 11715.2 11812.4 8764.6 8771.9 8800.6 9058.4 9224.0 10523.3 11242.9 11261.5 11263.5 11361.0 14:29:57 INFO - PROCESS | 29638 | 14:29:57 INFO - PROCESS | 29638 | [#3] mootools.html Cycles:180 Average:5955.54 Median:2505.92 stddev:3537.66 (141.2%) stddev-sans-first:3530.72 14:29:57 INFO - PROCESS | 29638 | Values: 1358.1 1422.8 1470.2 1712.0 1740.9 8736.9 9197.0 9272.8 9291.6 9311.4 7445.4 7552.3 7605.5 7814.8 8986.9 2191.1 2256.1 2269.7 2296.3 2299.8 2321.3 2332.3 2354.1 2355.2 2373.0 1971.0 2245.5 2353.6 2362.9 2364.9 2284.1 2309.2 2311.2 2317.3 2318.1 2245.3 2247.1 2250.9 2255.2 2268.2 8974.2 9081.6 9083.7 9083.9 9086.9 4933.1 5067.3 5070.7 5074.8 5076.5 3398.7 3461.9 3540.0 3548.2 3553.9 1163.5 1188.8 1194.7 1227.1 1229.8 13022.9 13026.0 13053.2 13088.5 13099.3 4563.4 4577.9 4670.8 4705.1 4783.0 10840.7 10849.3 10853.8 10861.7 10862.8 5247.0 5249.9 5252.8 5253.1 5255.0 4092.6 4698.1 4837.3 4843.6 4849.7 3987.2 3996.2 4105.4 4175.8 4185.2 1278.3 1298.9 1300.6 1312.8 1315.5 915.6 945.5 972.0 975.3 996.2 6057.6 6124.8 6131.7 6210.9 6288.8 428.0 431.9 433.1 439.9 448.4 3944.3 3987.4 4012.1 4032.5 4083.9 11166.4 11676.6 11755.2 11756.0 11788.8 11631.8 11639.0 11639.8 11645.0 11651.0 7864.5 8203.4 8295.1 8457.3 8578.3 6175.3 6250.2 6278.9 6294.5 6347.9 10539.4 10857.3 10963.5 10966.9 11050.6 10911.2 10956.9 11065.4 11068.9 11083.8 7314.1 7643.1 7751.9 7953.1 8261.1 9069.5 9092.5 9135.2 9161.7 9174.8 7818.6 8080.7 8127.6 8177.8 8228.9 7760.8 7764.6 7906.0 7942.3 8112.7 6862.9 7215.9 7344.7 7397.2 7413.7 4959.9 4976.3 5024.6 5030.5 5089.9 5152.0 5255.9 5258.2 5295.4 5320.4 14:29:57 INFO - PROCESS | 29638 | 14:29:57 INFO - PROCESS | 29638 | [#4] prototype.html Cycles:180 Average:4656.32 Median:5278.28 stddev:1360.92 (25.8%) stddev-sans-first:1325.35 14:29:57 INFO - PROCESS | 29638 | Values: 325.5 326.1 335.9 338.3 344.8 5227.3 5400.1 5453.2 5463.0 5494.6 5426.2 5430.6 5433.3 5457.0 5457.9 4206.4 4217.0 4217.4 4229.6 4242.2 4023.4 4141.1 4245.6 4257.1 4262.6 4172.6 4215.3 4237.2 4244.5 4272.3 4233.2 4236.6 4241.4 4254.6 4284.7 3605.4 3757.8 3768.2 3788.0 3789.9 5266.5 5277.8 5300.0 5303.9 5352.5 4823.3 4824.3 4873.3 4891.3 4897.8 5419.3 5602.7 5648.8 5666.4 5712.3 3986.0 3998.5 4000.5 4008.1 4027.0 5964.2 5981.8 5987.9 6009.3 6011.6 3962.5 4155.9 4162.5 4164.9 4165.4 4197.6 4219.9 4224.9 4229.4 4243.2 4812.4 4833.0 4851.4 4869.1 4883.6 5533.4 5696.9 5699.6 5719.4 5805.3 1382.1 1425.6 1425.6 1442.8 1448.9 967.3 974.4 987.2 991.7 998.6 5470.5 5480.0 5489.5 5494.9 5507.4 5729.8 5742.0 5773.6 5795.4 5797.8 5251.6 5481.3 5491.7 5511.4 5515.9 2710.6 2730.7 2732.9 2733.7 2759.4 5266.3 5278.7 5279.4 5284.6 5299.4 5030.4 5126.9 5274.6 5284.2 5288.7 5225.9 5227.9 5273.9 5325.0 5331.3 4959.6 5113.7 5143.8 5169.9 5187.6 5068.5 5088.6 5091.3 5103.3 5122.7 5289.3 5301.3 5301.9 5310.7 5343.6 3734.1 3743.2 3743.9 3809.7 3826.2 5417.1 5611.7 5770.8 5898.2 5919.7 5622.4 5639.8 5646.8 5723.2 5760.8 5687.2 5700.8 5807.6 5835.9 5848.9 5627.7 5645.4 5653.4 5654.4 5695.9 5768.3 5788.0 5801.5 5810.4 5811.9 5505.9 5613.0 5627.7 5685.8 5740.3 14:29:57 INFO - PROCESS | 29638 | 14:29:57 INFO - PROCESS | 29638 | [#5] yui.html Cycles:180 Average:20497.94 Median:4520.02 stddev:29368.66 (649.7%) stddev-sans-first:29413.48 14:29:57 INFO - PROCESS | 29638 | Values: 715.5 726.3 783.9 808.5 815.5 13556.6 14290.8 14405.6 14434.9 14436.4 14523.6 14585.1 14607.3 14607.4 14624.4 656.6 767.4 777.7 795.9 797.3 799.4 800.4 801.7 801.8 803.1 835.4 836.5 836.7 836.8 838.4 688.3 815.2 820.0 824.0 825.8 616.3 616.3 617.0 617.2 618.0 15112.2 15132.2 15162.2 15182.9 15184.8 14055.8 14457.0 14516.4 14533.4 14555.7 12787.5 12837.6 12886.1 12899.8 13157.0 4338.3 4360.3 4372.0 4482.7 4557.3 72548.3 72662.0 73605.3 73911.3 76643.6 11161.2 11176.0 11189.0 11473.5 11634.2 20923.8 20956.4 21017.9 21021.6 21046.0 8557.9 8615.5 8637.7 8848.4 9017.5 4794.2 4862.2 4880.4 4898.5 4971.4 3155.3 3225.0 3228.0 3234.5 3263.6 613.5 645.6 652.2 663.7 664.1 554.4 571.7 630.9 662.1 716.7 9898.8 9990.0 10061.7 10130.7 10299.3 680.6 698.7 717.6 718.4 739.1 4818.7 5014.2 5108.9 5111.6 5112.1 99167.0 124711.0 130711.3 133168.0 134683.0 72788.6 95209.5 95549.5 96359.0 96504.0 52611.0 53473.5 73887.3 84448.6 84935.6 10185.9 10484.3 10602.6 10642.4 10741.4 49005.3 50325.0 50876.7 51375.2 51862.0 67805.7 74361.3 74939.3 76570.6 76636.6 13416.3 13506.4 13536.7 13879.4 14066.9 14068.6 14452.5 14478.0 14589.3 15838.4 14721.3 14812.0 14830.7 15545.6 15775.8 14138.7 14139.8 14186.9 14363.4 14747.3 14161.4 14218.9 14779.4 14943.6 15012.5 11460.0 11516.8 11646.5 11892.3 11901.6 12201.9 12298.3 12306.3 12675.9 12726.4 14:29:57 INFO - PROCESS | 29638 | -------- Summary: end -------- 14:29:57 INFO - PROCESS | 29638 | 14:29:57 INFO - TEST-INFO | 29638: exit 0 14:29:57 INFO - TEST-OK | dromaeo_css | took 1113804ms 14:29:57 INFO - TEST-START | kraken 14:29:57 INFO - operating with platform_type : linux_ 14:29:57 INFO - Initialising browser for kraken test... 14:29:57 INFO - TEST-INFO | started process 29832 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprONbPX/profile http://localhost:39769/getInfo.html) 14:30:01 INFO - PROCESS | 29832 | __metrics Screen width/height:1600/1200 14:30:01 INFO - PROCESS | 29832 | colorDepth:24 14:30:01 INFO - PROCESS | 29832 | Browser inner width/height: 1024/697 14:30:01 INFO - PROCESS | 29832 | __metrics 14:30:02 INFO - PROCESS | 29832 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:30:02 INFO - PROCESS | 29832 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:30:03 INFO - TEST-INFO | 29832: exit 0 14:30:03 INFO - Browser initialized. 14:30:03 INFO - Running cycle 1/1 for kraken test... 14:30:03 INFO - TEST-INFO | started process 29915 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprONbPX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:30:15 INFO - PROCESS | 29915 | RSS: Main: 157700096 14:30:15 INFO - PROCESS | 29915 | 14:30:17 INFO - PROCESS | 29915 | Cycle 1(1): loaded http://localhost:39769/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39769/tests/kraken/driver.html?testName=audio-beat-detection) 14:30:18 INFO - PROCESS | 29915 | RSS: Main: 215826432 14:30:18 INFO - PROCESS | 29915 | 14:30:21 INFO - PROCESS | 29915 | Cycle 1(1): loaded http://localhost:39769/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39769/tests/kraken/driver.html?testName=audio-dft) 14:30:21 INFO - PROCESS | 29915 | RSS: Main: 203444224 14:30:21 INFO - PROCESS | 29915 | 14:30:24 INFO - PROCESS | 29915 | Cycle 1(1): loaded http://localhost:39769/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39769/tests/kraken/driver.html?testName=audio-fft) 14:30:25 INFO - PROCESS | 29915 | RSS: Main: 268914688 14:30:25 INFO - PROCESS | 29915 | 14:30:27 INFO - PROCESS | 29915 | Cycle 1(1): loaded http://localhost:39769/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39769/tests/kraken/driver.html?testName=audio-oscillator) 14:30:28 INFO - PROCESS | 29915 | RSS: Main: 180813824 14:30:28 INFO - PROCESS | 29915 | 14:30:30 INFO - PROCESS | 29915 | Cycle 1(1): loaded http://localhost:39769/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39769/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:30:30 INFO - PROCESS | 29915 | RSS: Main: 184066048 14:30:30 INFO - PROCESS | 29915 | 14:30:33 INFO - PROCESS | 29915 | Cycle 1(1): loaded http://localhost:39769/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39769/tests/kraken/driver.html?testName=imaging-darkroom) 14:30:34 INFO - PROCESS | 29915 | RSS: Main: 219078656 14:30:34 INFO - PROCESS | 29915 | 14:30:37 INFO - PROCESS | 29915 | Cycle 1(1): loaded http://localhost:39769/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39769/tests/kraken/driver.html?testName=imaging-desaturate) 14:30:38 INFO - PROCESS | 29915 | RSS: Main: 220631040 14:30:38 INFO - PROCESS | 29915 | 14:30:41 INFO - PROCESS | 29915 | Cycle 1(1): loaded http://localhost:39769/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39769/tests/kraken/driver.html?testName=json-parse-financial) 14:30:41 INFO - PROCESS | 29915 | RSS: Main: 220913664 14:30:41 INFO - PROCESS | 29915 | 14:30:43 INFO - PROCESS | 29915 | Cycle 1(1): loaded http://localhost:39769/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39769/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:30:43 INFO - PROCESS | 29915 | RSS: Main: 208760832 14:30:43 INFO - PROCESS | 29915 | 14:30:45 INFO - PROCESS | 29915 | Cycle 1(1): loaded http://localhost:39769/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39769/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:30:46 INFO - PROCESS | 29915 | RSS: Main: 211652608 14:30:46 INFO - PROCESS | 29915 | 14:30:48 INFO - PROCESS | 29915 | Cycle 1(1): loaded http://localhost:39769/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39769/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:30:49 INFO - PROCESS | 29915 | RSS: Main: 209694720 14:30:49 INFO - PROCESS | 29915 | 14:30:51 INFO - PROCESS | 29915 | Cycle 1(1): loaded http://localhost:39769/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39769/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:30:52 INFO - PROCESS | 29915 | RSS: Main: 231854080 14:30:52 INFO - PROCESS | 29915 | 14:30:54 INFO - PROCESS | 29915 | Cycle 1(1): loaded http://localhost:39769/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39769/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:30:55 INFO - PROCESS | 29915 | RSS: Main: 226836480 14:30:55 INFO - PROCESS | 29915 | 14:30:57 INFO - PROCESS | 29915 | Cycle 1(1): loaded http://localhost:39769/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39769/tests/kraken/driver.html?testName=ai-astar) 14:30:57 INFO - PROCESS | 29915 | RSS: Main: 268636160 14:30:57 INFO - PROCESS | 29915 | 14:30:57 INFO - PROCESS | 29915 | __start_tp_report 14:30:57 INFO - PROCESS | 29915 | _x_x_mozilla_page_load 14:30:57 INFO - PROCESS | 29915 | _x_x_mozilla_page_load_details 14:30:57 INFO - PROCESS | 29915 | |i|pagename|runs| 14:30:57 INFO - PROCESS | 29915 | |0;ai-astar;102;112;110;109;112;110;109;111;110;109 14:30:57 INFO - PROCESS | 29915 | |1;audio-beat-detection;143;118;125;172;117;117;139;115;155;116 14:30:57 INFO - PROCESS | 29915 | |2;audio-dft;162;163;168;159;158;160;160;161;160;161 14:30:57 INFO - PROCESS | 29915 | |3;audio-fft;74;75;75;137;77;75;76;75;98;75 14:30:57 INFO - PROCESS | 29915 | |4;audio-oscillator;83;84;110;83;83;83;116;84;84;127 14:30:57 INFO - PROCESS | 29915 | |5;imaging-gaussian-blur;117;117;117;117;118;116;117;116;117;120 14:30:57 INFO - PROCESS | 29915 | |6;imaging-darkroom;146;146;145;146;146;147;146;146;146;146 14:30:57 INFO - PROCESS | 29915 | |7;imaging-desaturate;95;95;96;95;95;95;95;95;95;95 14:30:57 INFO - PROCESS | 29915 | |8;json-parse-financial;52;53;53;52;52;53;55;53;51;52 14:30:57 INFO - PROCESS | 29915 | |9;json-stringify-tinderbox;63;64;64;63;63;63;63;64;64;63 14:30:57 INFO - PROCESS | 29915 | |10;stanford-crypto-aes;75;75;75;74;78;76;77;75;77;78 14:30:57 INFO - PROCESS | 29915 | |11;stanford-crypto-ccm;120;119;117;125;131;125;123;119;173;128 14:30:57 INFO - PROCESS | 29915 | |12;stanford-crypto-pbkdf2;159;155;158;152;154;154;162;154;153;153 14:30:57 INFO - PROCESS | 29915 | |13;stanford-crypto-sha256-iterative;63;66;64;63;62;63;62;63;61;61 14:30:57 INFO - PROCESS | 29915 | __end_tp_report 14:30:57 INFO - PROCESS | 29915 | __start_cc_report 14:30:57 INFO - PROCESS | 29915 | _x_x_mozilla_cycle_collect,1660 14:30:57 INFO - PROCESS | 29915 | __end_cc_report 14:30:57 INFO - PROCESS | 29915 | __startTimestamp1468359057352__endTimestamp 14:30:57 INFO - PROCESS | 29915 | 14:30:57 INFO - PROCESS | 29915 | ------- Summary: start ------- 14:30:57 INFO - PROCESS | 29915 | Number of tests: 14 14:30:57 INFO - PROCESS | 29915 | 14:30:57 INFO - PROCESS | 29915 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:2.84 (2.6%) stddev-sans-first:1.20 14:30:57 INFO - PROCESS | 29915 | Values: 102.0 112.0 110.0 109.0 112.0 110.0 109.0 111.0 110.0 109.0 14:30:57 INFO - PROCESS | 29915 | 14:30:57 INFO - PROCESS | 29915 | [#1] audio-beat-detection Cycles:10 Average:131.70 Median:132.00 stddev:19.83 (15.0%) stddev-sans-first:20.60 14:30:57 INFO - PROCESS | 29915 | Values: 143.0 118.0 125.0 172.0 117.0 117.0 139.0 115.0 155.0 116.0 14:30:57 INFO - PROCESS | 29915 | 14:30:57 INFO - PROCESS | 29915 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:2.78 (1.7%) stddev-sans-first:2.93 14:30:57 INFO - PROCESS | 29915 | Values: 162.0 163.0 168.0 159.0 158.0 160.0 160.0 161.0 160.0 161.0 14:30:57 INFO - PROCESS | 29915 | 14:30:57 INFO - PROCESS | 29915 | [#3] audio-fft Cycles:10 Average:83.70 Median:75.00 stddev:20.06 (26.7%) stddev-sans-first:20.97 14:30:57 INFO - PROCESS | 29915 | Values: 74.0 75.0 75.0 137.0 77.0 75.0 76.0 75.0 98.0 75.0 14:30:57 INFO - PROCESS | 29915 | 14:30:57 INFO - PROCESS | 29915 | [#4] audio-oscillator Cycles:10 Average:93.70 Median:83.00 stddev:17.04 (20.5%) stddev-sans-first:17.62 14:30:57 INFO - PROCESS | 29915 | Values: 83.0 84.0 110.0 83.0 83.0 83.0 116.0 84.0 84.0 127.0 14:30:57 INFO - PROCESS | 29915 | 14:30:57 INFO - PROCESS | 29915 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:1.14 (1.0%) stddev-sans-first:1.20 14:30:57 INFO - PROCESS | 29915 | Values: 117.0 117.0 117.0 117.0 118.0 116.0 117.0 116.0 117.0 120.0 14:30:57 INFO - PROCESS | 29915 | 14:30:57 INFO - PROCESS | 29915 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 14:30:57 INFO - PROCESS | 29915 | Values: 146.0 146.0 145.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 14:30:57 INFO - PROCESS | 29915 | 14:30:57 INFO - PROCESS | 29915 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 14:30:57 INFO - PROCESS | 29915 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 14:30:57 INFO - PROCESS | 29915 | 14:30:57 INFO - PROCESS | 29915 | [#8] json-parse-financial Cycles:10 Average:52.60 Median:53.00 stddev:1.07 (2.0%) stddev-sans-first:1.12 14:30:57 INFO - PROCESS | 29915 | Values: 52.0 53.0 53.0 52.0 52.0 53.0 55.0 53.0 51.0 52.0 14:30:57 INFO - PROCESS | 29915 | 14:30:57 INFO - PROCESS | 29915 | [#9] json-stringify-tinderbox Cycles:10 Average:63.40 Median:63.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 14:30:57 INFO - PROCESS | 29915 | Values: 63.0 64.0 64.0 63.0 63.0 63.0 63.0 64.0 64.0 63.0 14:30:57 INFO - PROCESS | 29915 | 14:30:57 INFO - PROCESS | 29915 | [#10] stanford-crypto-aes Cycles:10 Average:76.00 Median:76.50 stddev:1.41 (1.8%) stddev-sans-first:1.45 14:30:57 INFO - PROCESS | 29915 | Values: 75.0 75.0 75.0 74.0 78.0 76.0 77.0 75.0 77.0 78.0 14:30:57 INFO - PROCESS | 29915 | 14:30:57 INFO - PROCESS | 29915 | [#11] stanford-crypto-ccm Cycles:10 Average:128.00 Median:125.00 stddev:16.41 (13.1%) stddev-sans-first:17.15 14:30:57 INFO - PROCESS | 29915 | Values: 120.0 119.0 117.0 125.0 131.0 125.0 123.0 119.0 173.0 128.0 14:30:57 INFO - PROCESS | 29915 | 14:30:57 INFO - PROCESS | 29915 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.40 Median:154.50 stddev:3.20 (2.1%) stddev-sans-first:3.12 14:30:57 INFO - PROCESS | 29915 | Values: 159.0 155.0 158.0 152.0 154.0 154.0 162.0 154.0 153.0 153.0 14:30:57 INFO - PROCESS | 29915 | 14:30:57 INFO - PROCESS | 29915 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:63.00 stddev:1.48 (2.3%) stddev-sans-first:1.56 14:30:57 INFO - PROCESS | 29915 | Values: 63.0 66.0 64.0 63.0 62.0 63.0 62.0 63.0 61.0 61.0 14:30:57 INFO - PROCESS | 29915 | -------- Summary: end -------- 14:30:57 INFO - PROCESS | 29915 | 14:30:58 INFO - TEST-INFO | 29915: exit 0 14:30:58 INFO - TEST-OK | kraken | took 60422ms 14:30:58 INFO - SUITE-END | took 1174s 14:30:58 INFO - Completed test suite (00:19:34) 14:30:58 INFO - javascript benchmark 14:30:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2992.9401411971776, 3025.2739342557793, 3030.696930306968, 3098.2409309719114, 3148.433282009238, 5406.702631355274, 5495.120780675093, 5528.474794894483, 5576.191452239423, 5588.8602784930345, 5505.449455054492, 5554.444555544444, 5563.693996830173, 5612.214289999393, 5672.262605861242, 4996.925046124311, 5018.021485810268, 5018.548330650241, 5038.974805125988, 5129.769160387791, 5093.923591146136, 5111.437741848394, 5174.586033117342, 5220.92168617471, 5230.21546767984, 4956.603471722254, 5125.487451254863, 5132.358455193101, 5163.561097306733, 5188.221766734982, 4943.728094954776, 4955.1080805455, 5004.599632029429, 5053.36832895888, 5056.924146137811, 5014.548690617826, 5027.195648696191, 5073.2897394364445, 5089.567386772129, 5136.717480538568, 5405.837824865261, 5588.608797384185, 5602.38373778884, 5626.043572592669, 5653.943460565424, 5781.855453613652, 5856.472917437451, 5861.6189947653265, 5893.852653683693, 5904.704764761745, 5854.912176317359, 5974.193483879664, 5989.071693887455, 5993.340732519419, 5993.951058564734, 5453.972730136324, 5457.590680698963, 5555.833325000256, 5568.749406276727, 5569.66582005081, 6070.119832624333, 6108.8884676397665, 6110.285381942539, 6112.419320164578, 6112.480439162632, 5885.764569417261, 5886.6173698709445, 5890.293164820249, 5893.705314734246, 5897.3807750185615, 5735.283089613798, 5837.883242335214, 5891.23413956183, 5982.282126144803, 5988.461038506555, 5888.852778680482, 5889.087191485327, 5892.793752218738, 5902.911456328158, 5932.139839723216, 5866.5893387462465, 5914.142449344907, 5919.378465261172, 5919.526437884959, 5920.911186332209, 4374.912501749947, 4434.600885920283, 4466.464024317038, 4470.932936005963, 4507.368968344369, 3943.132510847609, 3943.408488726714, 3954.209158168378, 3988.521377434726, 3998.4402183694306, 5594.1608758686525, 5598.1602759586385, 5600.131979543095, 5606.579506537026, 5607.299087614048, 5811.883762324815, 5878.382769809194, 5908.05471124618, 5927.881442371128, 5975.910361344583, 5590.077637189899, 5592.86017849557, 5603.607747457639, 5605.187247849039, 5610.831675049755, 4916.434610019822, 5091.41448733393, 5106.412762532282, 5111.539961403417, 5160.92258616121, 5976.850578735566, 6054.606450580698, 6061.212042434456, 6093.146959425684, 6096.695165241809, 5858.502027327725, 5865.677387743715, 5873.060310350324, 5889.263842019747, 5898.056310990392, 5899.292084949833, 6057.727402266997, 6066.18106555627, 6074.3014553325165, 6075.665838378932, 5805.071188609802, 5819.854503637443, 5825.70871456434, 5831.125331200354, 5891.0, 5885.676287804212, 5899.203607512931, 5943.0, 5952.077427998667, 5959.046552551571, 5614.242077319673, 5696.0, 5746.080627099644, 5824.417558244142, 5829.679367634821, 5766.884662306814, 5772.393898640582, 5781.075027995669, 5781.797637082682, 5841.18223448726, 5704.743286552032, 5710.800121995876, 5713.285839270091, 5714.20001199824, 5717.799877004285, 5681.744321505459, 5786.739596718074, 5807.709614519342, 5856.531477481876, 5858.502027327725, 5622.493975542057, 5672.4894759471845, 5688.0, 5708.80019199326, 5745.253117094751], "value": 5445.59965281531, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.472862059836, 601.7532811547267, 619.2228752915091, 622.1725105609539, 637.7927173668559, 42248.788756056216, 43738.781306093464, 43830.780846095804, 43987.78006109965, 47396.76301618487, 44848.103037939225, 45103.0, 45378.54621453785, 45384.0, 45423.0, 7902.051753789553, 8955.41789783662, 9103.499307538083, 9104.954475227647, 10483.947580262087, 10505.737356566071, 10842.186835987293, 10914.181436392262, 10918.0, 10925.235233533616, 10874.18443616728, 10943.28868623541, 10952.945235273812, 10955.890441095567, 10963.56145754169, 8072.959635201816, 10665.200109991782, 10761.946190269038, 10932.617358392497, 10969.067629251444, 10524.0, 10898.182636302308, 10903.182261330352, 10903.781924361469, 10913.181511386598, 33055.83472082648, 42158.57841421577, 42540.78729606363, 42665.14669706619, 42773.786131069144, 3067.2945222598705, 3171.5084161954933, 3306.7850589711834, 3382.6109997350372, 3416.7266618670446, 33607.83196084028, 33827.661723382946, 34075.488867667, 34079.829600852085, 34126.82936585301, 4571.9542804571865, 4613.95386046142, 4622.976885115587, 4641.582257596799, 4747.35910652061, 368540.0, 370523.0, 372013.0, 372048.1397593022, 372429.0, 63132.36867631357, 63134.0, 63424.68287658532, 63704.0, 63715.36284637095, 37012.81493592515, 37989.43015854764, 38000.23999519994, 40037.39943900844, 40104.0, 15679.608009799846, 15762.527124186292, 15780.60548486297, 15786.36854525829, 15821.367145314058, 12548.623541293775, 13394.062415630813, 13635.113717608323, 13703.657408564866, 14151.009429340053, 20494.487637809176, 20816.47958801042, 20856.270030548858, 20914.686279705817, 20991.895040524698, 7606.315431611181, 7700.884486732703, 7763.456558040883, 7808.0, 8009.3192078673965, 982.4792859784326, 1128.9209755317213, 1137.5248615479625, 1148.488922429511, 1167.9708007299716, 34015.489767653504, 34079.0, 34167.316653666785, 34178.829105854806, 34387.4841877372, 1006.9194464442827, 1026.1124127629546, 1041.390786389955, 1079.4980334144661, 1115.6151127861037, 17528.47414577539, 17585.472435826945, 17693.399716073913, 17823.46529604114, 17866.0, 608545.0, 615509.0, 616175.0, 616228.0, 616489.0, 57665.71167144137, 58990.0, 58991.0, 59007.40992590019, 59100.40899591035, 1217.1358335581658, 1231.4704676988802, 1333.5799223244646, 1367.7674795285025, 1378.152436251698, 32804.67195328112, 35198.82400588083, 35281.0, 35358.292834143685, 35983.82008090048, 55916.0, 57389.0, 57421.71289143527, 62843.6857815708, 63123.84380780851, 523203.0, 535924.883380241, 536290.0, 536511.0, 537124.0, 37307.25385492329, 42823.143537129705, 46364.30453543132, 48229.0, 48590.757046214545, 49299.7003693119, 49372.0, 50397.74801125971, 50444.99110017852, 50623.74688126536, 41236.38145427881, 41427.37858932179, 42282.36576451294, 42414.28132951728, 42686.78656606697, 41687.374689379074, 41824.581754182065, 41887.0, 42454.78772606117, 42691.57308427, 35641.28717425585, 36265.27469450543, 36491.0, 36564.634353656125, 36576.26847463089, 28722.081579460366, 31416.057518274487, 31436.77846201269, 31669.683303166672, 31834.044978650676, 25198.496030079663, 25360.619590705785, 25697.871510642326, 25763.0, 26136.215913522625], "value": 21015.06830090359, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.56868875548145, 392.8840991907387, 394.026753917823, 398.5775078416878, 423.45163013897, 13666.619054420778, 18713.251469941188, 18997.620047599055, 20553.588928221427, 20567.074481648324, 15319.0, 16676.249568769403, 17424.390146344882, 17650.558736031606, 17898.37355692551, 5585.441455854423, 5753.856153596152, 5761.366249712528, 5768.509676677467, 5768.567357448187, 5531.529819965288, 5572.944270557304, 5578.330600327967, 5583.637063590853, 5586.916196257039, 4194.161167766443, 4378.6934914555995, 4561.361409402686, 6305.9684701576425, 6331.525135614825, 6214.316425193225, 6376.649284289362, 6423.036544518313, 6429.35706429358, 6429.678516074201, 5600.831975040755, 5605.57958153136, 5633.521150702195, 5651.943480565183, 5655.321361436613, 21480.570388592296, 23156.42108947273, 23317.0, 23600.881995590084, 23856.284311470685, 2456.078970386105, 2481.404462928884, 2763.9220703925484, 2882.2506148401358, 2910.9272268193254, 9825.508724563815, 10084.142847857867, 10281.948590257076, 12204.450799714034, 13525.932370338085, 1910.1595298068805, 1964.8722833015809, 1980.069367397321, 1995.1321175288651, 2030.6750919852752, 85436.57281713614, 85731.0, 86214.0, 86977.75258326666, 87941.56029219877, 10191.796164076677, 10239.692809215736, 10389.376637401629, 10401.68794936153, 11443.25618834773, 14373.06575072617, 14468.27658617065, 14468.85531144675, 14476.0, 14480.0, 7925.960370198228, 8291.751247462586, 8322.0, 8342.791430214293, 8375.288100511525, 8235.21765432283, 8243.25810677042, 8323.875141872877, 8442.873356899652, 8517.190866867637, 4537.001859590885, 4564.246899261585, 4576.199165146086, 4598.609118224988, 4616.146012987608, 1828.789689185734, 1857.4149143019906, 1892.3093071028975, 1962.8724132931313, 1996.3112726109468, 1019.3425240719695, 1070.566420599643, 1076.7200527862656, 1094.6551836171739, 1097.91765617579, 18966.620667586845, 19769.209231630575, 19770.20919163246, 19879.204831806564, 20349.49126271855, 1008.2135933971514, 1026.4559783314855, 1031.4533297352416, 1045.7764415633726, 1119.171812858479, 10667.893321066846, 10702.732431689114, 11010.614628488125, 11073.667789966314, 11123.55505779776, 374072.0, 377884.0, 494188.0, 498375.0, 501340.0, 59852.0, 69691.65154174298, 104425.0, 105158.0, 108020.45989770001, 980.9117179453883, 1015.8577799108131, 1027.5530144387214, 1055.8785739639886, 1056.6143357674393, 17465.82534174642, 17613.735793962845, 17953.0, 17978.190981405605, 18320.17559209812, 41179.58820411877, 45966.0, 46530.53469465397, 46537.301940471596, 46711.0, 53079.734601326745, 61773.38226617676, 62540.0, 63109.36890631035, 64310.0, 8468.830623387621, 8481.491110533389, 8779.824403511766, 8873.423227490193, 8935.553222338987, 8644.827103458021, 13302.201867887958, 13507.122037067558, 13619.659508512366, 14292.0, 11238.494267758135, 11502.367369794742, 11643.12676549279, 11784.234024788362, 11968.76062478763, 11846.11154163424, 12061.336626485627, 12282.692932676755, 12355.814662780245, 12562.183458075197, 11507.654770356903, 11549.0, 11636.53453861836, 11715.1799374043, 11812.40937953116, 8764.561771911507, 8771.868421973548, 8800.60397282111, 9058.411203271766, 9224.0, 10523.263371563917, 11242.931921467447, 11261.49323280438, 11263.493142808757, 11361.0], "value": 9297.774401171568, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1358.096865584386, 1422.7652437347838, 1470.21343581184, 1711.95272415101, 1740.8520275776566, 8736.912630873689, 9196.954015229914, 9272.768180795467, 9291.559808229727, 9311.441313521193, 7445.404367650589, 7552.320291173807, 7605.543667379961, 7814.843703125934, 8986.910130898688, 2191.145453273221, 2256.0862850545554, 2269.704938358011, 2296.2537175417974, 2299.839011269212, 2321.3152120124605, 2332.288651961151, 2354.09367393553, 2355.222776483756, 2372.9914786215877, 1970.980290197101, 2245.5396643688086, 2353.6116540770754, 2362.870042147681, 2364.8817559122062, 2284.0521183708743, 2309.2379514760087, 2311.2257393773107, 2317.2816426907543, 2318.13070098713, 2245.2590645087244, 2247.1123906057014, 2250.932472025842, 2255.2444930948154, 2268.194790849241, 8974.192322690924, 9081.59132839024, 9083.7274881753, 9083.909160908372, 9086.863697044484, 4933.062718083553, 5067.265246539268, 5070.72111033893, 5074.847754567369, 5076.466970968032, 3398.7111095556907, 3461.913452163691, 3540.044188069233, 3548.1661809474754, 3553.893383198508, 1163.4764356039732, 1188.7860185166667, 1194.6834088966432, 1227.1226073357593, 1229.7970834812334, 13022.934885325607, 13026.023048271323, 13053.15154514963, 13088.47646094155, 13099.279539625317, 4563.429571303587, 4577.931331030038, 4670.8365207217585, 4705.058988202373, 4783.0, 10840.67477975662, 10849.349039057683, 10853.782924341469, 10861.674149775361, 10862.837057444145, 5247.02929957959, 5249.947500525022, 5252.763625636855, 5253.080710875582, 5254.973725131426, 4092.6112019358116, 4698.060387922429, 4837.250226214942, 4843.564079232886, 4849.684770489906, 3987.1626958339075, 3996.2207369562657, 4105.384192371109, 4175.791210439526, 4185.183889141649, 1278.3033246880473, 1298.9480420783063, 1300.5708116321591, 1312.7768279392526, 1315.4803852478408, 915.624593916491, 945.546137853834, 971.9805603887883, 975.327024353194, 996.1781530237583, 6057.636541807506, 6124.846878827976, 6131.693415329216, 6210.937890621036, 6288.842778930563, 428.00488863392735, 431.8833914842975, 433.1099590341878, 439.8724369932748, 448.41257952082225, 3944.3491823848744, 3987.4218238355274, 4012.0972781124015, 4032.5160980681917, 4083.89790255246, 11166.441677916235, 11676.591319303783, 11755.177137600285, 11756.0, 11788.764224715458, 11631.825522617168, 11639.010684091947, 11639.76720465603, 11645.010174135294, 11651.0, 7864.5281283123195, 8203.384746144064, 8295.087540370554, 8457.323414126855, 8578.313734901192, 6175.320714721287, 6250.187475628321, 6278.937210627835, 6294.464970477377, 6347.936520634919, 10539.367637941441, 10857.294275872358, 10963.451827408757, 10966.945165274123, 11050.613228537284, 10911.181661375269, 10956.890431095906, 11065.391403472886, 11068.889311106786, 11083.778324433304, 7314.122305323395, 7643.082830060428, 7751.92248077512, 7953.085395179397, 8261.13258107914, 9069.546522673709, 9092.454452732858, 9135.2235060018, 9161.725148245563, 9174.770630734285, 7818.648160832662, 8080.676772929017, 8127.593620319079, 8177.795555110932, 8228.876566851623, 7760.84478310442, 7764.611769411394, 7905.960470197612, 7942.285194332538, 8112.675492980215, 6862.862742745217, 7215.927840721525, 7344.742933997284, 7397.1863095058425, 7413.666385012795, 4959.925601115914, 4976.328195693535, 5024.57291130258, 5030.496950304941, 5089.8727531812, 5152.0, 5255.9211611825085, 5258.158694608845, 5295.417504074471, 5320.388155362183], "value": 4624.0347812084665, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.49548200289547, 326.13574028823615, 335.8774047472672, 338.34361339002334, 344.83275611328486, 5227.26818245445, 5400.108982017962, 5453.236546883434, 5462.972685136579, 5494.587905907053, 5426.186072089188, 5430.59270554708, 5433.320834895638, 5457.0, 5457.945420545793, 4206.390073439357, 4217.0, 4217.388478670591, 4229.6404805591565, 4242.215190189825, 4023.356262997921, 4141.0744004038115, 4245.575442455745, 4257.14857028594, 4262.616364527192, 4172.603602657743, 4215.3044747616605, 4237.173751118533, 4244.493204912258, 4272.295071313245, 4233.216854881842, 4236.5763423657545, 4241.448611680462, 4254.595813397753, 4284.721493102969, 3605.405108157151, 3757.793321367351, 3768.1898391845884, 3787.962120378816, 3789.9242015159816, 5266.4733526647415, 5277.815276465305, 5299.973500132513, 5303.893922121536, 5352.491513306269, 4823.311840855672, 4824.348712923746, 4873.34209881665, 4891.315215869781, 4897.804087836482, 5419.295491586068, 5602.747876345574, 5648.802291919804, 5666.376698563155, 5712.2574065371655, 3985.9636494511346, 3998.4801975743258, 4000.5199376074765, 4008.118213992917, 4027.0, 5964.165016897595, 5981.790637327673, 5987.850303742398, 6009.308929473123, 6011.609245399035, 3962.465067215889, 4155.896102597399, 4162.500499939966, 4164.8542301019925, 4165.354370072643, 4197.601227883346, 4219.945013746564, 4224.8732538023905, 4229.407882896397, 4243.215005224043, 4812.374391329105, 4832.95167048325, 4851.393575803025, 4869.14789911764, 4883.609311255091, 5533.446655334435, 5696.857578560569, 5699.601027928005, 5719.370869204384, 5805.332386775491, 1382.0740104130257, 1425.5652026131922, 1425.5865798918198, 1442.8268607766925, 1448.898577099593, 967.3373738988674, 974.3910056214866, 987.2151639446657, 991.6975322526555, 998.605550807427, 5470.5350045245805, 5480.013597552399, 5489.505944464938, 5494.862628434321, 5507.449255074541, 5729.7708091676695, 5741.971290143606, 5773.624714393635, 5795.391483894215, 5797.826065218051, 5251.579873610102, 5481.287432633732, 5491.670499770026, 5511.421300763443, 5515.889682206333, 2710.587577056382, 2730.6586676665415, 2732.8547090533834, 2733.7129601391966, 2759.379139693593, 5266.288456251734, 5278.736063196825, 5279.41926388097, 5284.599581111009, 5299.4435584263865, 5030.423163022796, 5126.87182820425, 5274.551663108602, 5284.154535274338, 5288.68267903927, 5225.895482090337, 5227.9215811763615, 5273.947260527422, 5324.9733751331, 5331.253624492574, 4959.578435832995, 5113.744312784272, 5143.8456846294675, 5169.932027189155, 5187.636865419385, 5068.467810879952, 5088.567471764942, 5091.319864444798, 5103.336566246364, 5122.667026643257, 5289.259503669412, 5301.284326615858, 5301.946980530145, 5310.742934252849, 5343.599230057839, 3734.122481216966, 3743.2326373092906, 3743.850245990239, 3809.7333186677774, 3826.234753049457, 5417.133258678593, 5611.719414029364, 5770.826875193751, 5898.233229680286, 5919.733611987384, 5622.353429355677, 5639.8308050756905, 5646.830595082154, 5723.170140329712, 5760.8271751847515, 5687.232223649919, 5700.800471983461, 5807.577143599845, 5835.94164058371, 5848.883022339444, 5627.662340259434, 5645.350784659817, 5653.40639232891, 5654.434556544313, 5695.914561281667, 5768.336641286306, 5787.974209026976, 5801.477866991991, 5810.360860305278, 5811.94188058114, 5505.944940550543, 5613.0, 5627.718614069362, 5685.800996965087, 5740.335302762152], "value": 4224.989915156072, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [715.5134508534198, 726.2773540327375, 783.9490433121848, 808.5027707959599, 815.461795215158, 13556.593302200938, 14290.785638215435, 14405.63985900353, 14434.85565144347, 14436.422543098277, 14523.636909077251, 14585.124892506457, 14607.342669579868, 14607.415703371878, 14624.415023399051, 656.5502630697987, 767.4436033875423, 777.6811507282016, 795.8925545051402, 797.3342259213564, 799.3844739550542, 800.4236949396454, 801.6913488307015, 801.7955421367573, 803.1045384396415, 835.3609488741118, 836.4939211776879, 836.7447928381841, 836.8117173635914, 838.4340570115178, 688.3460712323313, 815.229608020421, 820.024171236233, 823.9876401853977, 825.8059356051353, 616.2604874151036, 616.2974209401286, 616.9537284703621, 617.1976430640194, 617.9752809887599, 15112.168830714307, 15132.243387830564, 15162.241887905671, 15182.924085379613, 15184.772228416583, 14055.78916316256, 14457.0, 14516.419343226258, 14533.418663253457, 14555.70888582233, 12787.488500459971, 12837.550685726048, 12886.097973141885, 12899.789964064987, 13157.0, 4338.284183109815, 4360.258756011485, 4372.0, 4482.7310361378095, 4557.316402539613, 72548.27451725469, 72662.0, 73605.26394736038, 73911.26088739098, 76643.61678191573, 11161.172324575105, 11175.979983319505, 11189.0, 11473.483693233824, 11634.243774154653, 20923.79076209249, 20956.37130886076, 21017.89491052535, 21021.579568408546, 21046.0, 8557.914420855835, 8615.526146061902, 8637.740867773977, 8848.380613357003, 9017.549122543847, 4794.237761959441, 4862.246351815404, 4880.365552478155, 4898.485659005824, 4971.353724015927, 3155.2742869140225, 3225.048610659861, 3227.967720322814, 3234.4824828027404, 3263.6246831614194, 613.4662843326334, 645.6215978885114, 652.2075678051191, 663.6847497438678, 664.0935123556311, 554.3680204566797, 571.7427157778933, 630.9305976342598, 662.1392190152878, 716.6882406153236, 9898.80202395948, 9990.0, 10061.698149055394, 10130.746731331776, 10299.330543514647, 680.571240118722, 698.6611493425685, 717.5873872523216, 718.4360277182491, 739.1340866308662, 4818.6626936114835, 5014.247862820534, 5108.923366149511, 5111.642185047085, 5112.130937740593, 99167.0, 124711.0, 130711.34644326718, 133168.0, 134683.0, 72788.63605681938, 95209.52395238118, 95549.5222523883, 96359.0, 96504.0, 52611.0, 53473.46526534763, 73887.26112738911, 84448.57775711206, 84935.575322123, 10185.9490702546, 10484.266101373136, 10602.575896964036, 10642.361458312525, 10741.355518668592, 49005.2649210255, 50324.96100467967, 50876.745616271684, 51375.22937155871, 51861.962760743816, 67805.66097169483, 74361.25638743759, 74939.25060749323, 76570.61714691391, 76636.61681691778, 13416.262105584286, 13506.392212350664, 13536.661583460493, 13879.444822207402, 14066.929665351608, 14068.62524781914, 14452.494162704255, 14478.0, 14589.343479543659, 15838.366465341258, 14721.33753981095, 14812.0, 14830.703385932005, 15545.611359716098, 15775.763363549786, 14138.717225655635, 14139.787903181255, 14186.858131418554, 14363.425462981782, 14747.336369863167, 14161.43136406359, 14218.928905355408, 14779.408823646934, 14943.626409339853, 15012.47456339023, 11460.0, 11516.769664606829, 11646.534138634359, 11892.345920974429, 11901.583444579399, 12201.901828835447, 12298.262104273772, 12306.323152226714, 12675.873241267838, 12726.427310771223], "value": 7601.66606055434, "unit": "score"}], "name": "dromaeo_css", "value": 7352.916061893364, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 110.0, 109.0, 112.0, 110.0, 109.0, 111.0, 110.0, 109.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 118.0, 125.0, 172.0, 117.0, 117.0, 139.0, 115.0, 155.0, 116.0], "value": 131.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 168.0, 159.0, 158.0, 160.0, 160.0, 161.0, 160.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 137.0, 77.0, 75.0, 76.0, 75.0, 98.0, 75.0], "value": 83.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 110.0, 83.0, 83.0, 83.0, 116.0, 84.0, 84.0, 127.0], "value": 93.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 116.0, 117.0, 116.0, 117.0, 120.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 53.0, 52.0, 52.0, 53.0, 55.0, 53.0, 51.0, 52.0], "value": 52.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 63.0, 63.0, 63.0, 63.0, 64.0, 64.0, 63.0], "value": 63.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 74.0, 78.0, 76.0, 77.0, 75.0, 77.0, 78.0], "value": 76.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 119.0, 117.0, 125.0, 131.0, 125.0, 123.0, 119.0, 173.0, 128.0], "value": 128.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 155.0, 158.0, 152.0, 154.0, 154.0, 162.0, 154.0, 153.0, 153.0], "value": 155.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 64.0, 63.0, 62.0, 63.0, 62.0, 63.0, 61.0, 61.0], "value": 62.8, "unit": "score"}], "name": "kraken", "value": 1476.2, "alertThreshold": 2.0}]} 14:30:58 INFO - Return code: 0 14:30:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:30:58 INFO - # TBPL SUCCESS # 14:30:58 INFO - Running post-action listener: _resource_record_post_action 14:30:58 INFO - ##### 14:30:58 INFO - ##### Finished run-tests step (success) 14:30:58 INFO - ##### 14:30:58 INFO - Running post-run listener: _resource_record_post_run 14:30:58 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 567164928; Read time: 12; Write time: 510440 14:30:58 INFO - TinderboxPrint: CPU usage
13.0% 14:30:58 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 14:30:58 INFO - TinderboxPrint: I/O write bytes / time
567,164,928 / 510,440 14:30:58 INFO - TinderboxPrint: CPU idle
8,271.6 (86.9%) 14:30:58 INFO - TinderboxPrint: CPU user
1,199.0 (12.6%) 14:30:58 INFO - TinderboxPrint: Swap in / out
0 / 0 14:30:58 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 269783040; Read time: 0; Write time: 276976 14:30:58 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 296325120; Read time: 0; Write time: 233212 14:30:59 INFO - Running post-run listener: _upload_blobber_files 14:30:59 INFO - Blob upload gear active. 14:30:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:30:59 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:30:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:30:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:30:59 INFO - (blobuploader) - INFO - Open directory for files ... 14:30:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:30:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:30:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:31:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:31:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:31:03 INFO - (blobuploader) - INFO - Done attempting. 14:31:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:31:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:31:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:31:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:31:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:31:03 INFO - (blobuploader) - INFO - Done attempting. 14:31:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:31:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:31:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:31:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:31:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:31:04 INFO - (blobuploader) - INFO - Done attempting. 14:31:04 INFO - (blobuploader) - INFO - Iteration through files over. 14:31:04 INFO - Return code: 0 14:31:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:31:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:31:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d6704033858e2e4e422e688bf201e26c2949656de4a9f1494e726f087f23cf4da0fa7f578a425665792b3fccfb13a46e0f73d2b65b06ccc10de48386f6b483a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a3fa737beb44a338ebedb190d98b0e1d0c963fcf075f48c2f6faa59d7087e528e7ba724e1136617196725238c11395312dd397863e69d87719e8409342bc59c4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b7f39f5f0b8d8cc47f1126aecebb4755fe8932680f439155ab78d2197a9d3115904c0fcae8ef83c902a6f9a1600f31cff5fa81173f4554b2b35f5d92a105b8a"} 14:31:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:31:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:31:04 INFO - Contents: 14:31:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d6704033858e2e4e422e688bf201e26c2949656de4a9f1494e726f087f23cf4da0fa7f578a425665792b3fccfb13a46e0f73d2b65b06ccc10de48386f6b483a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a3fa737beb44a338ebedb190d98b0e1d0c963fcf075f48c2f6faa59d7087e528e7ba724e1136617196725238c11395312dd397863e69d87719e8409342bc59c4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b7f39f5f0b8d8cc47f1126aecebb4755fe8932680f439155ab78d2197a9d3115904c0fcae8ef83c902a6f9a1600f31cff5fa81173f4554b2b35f5d92a105b8a"} 14:31:04 INFO - Running post-run listener: copy_logs_to_upload_dir 14:31:04 INFO - Copying logs to upload dir... 14:31:04 INFO - mkdir: /builds/slave/test/build/upload/logs 14:31:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.755513 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-07-12 14:31:04.502625) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 14:31:04.506502) ========= 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=1f5564757af27664ca02d71f000001b0-1468357753.627468-1338201030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d6704033858e2e4e422e688bf201e26c2949656de4a9f1494e726f087f23cf4da0fa7f578a425665792b3fccfb13a46e0f73d2b65b06ccc10de48386f6b483a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a3fa737beb44a338ebedb190d98b0e1d0c963fcf075f48c2f6faa59d7087e528e7ba724e1136617196725238c11395312dd397863e69d87719e8409342bc59c4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b7f39f5f0b8d8cc47f1126aecebb4755fe8932680f439155ab78d2197a9d3115904c0fcae8ef83c902a6f9a1600f31cff5fa81173f4554b2b35f5d92a105b8a"} build_url:https://queue.taskcluster.net/v1/task/Lt3A8c1mR6OzXEYdSsfjyA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011249 build_url: 'https://queue.taskcluster.net/v1/task/Lt3A8c1mR6OzXEYdSsfjyA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d6704033858e2e4e422e688bf201e26c2949656de4a9f1494e726f087f23cf4da0fa7f578a425665792b3fccfb13a46e0f73d2b65b06ccc10de48386f6b483a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a3fa737beb44a338ebedb190d98b0e1d0c963fcf075f48c2f6faa59d7087e528e7ba724e1136617196725238c11395312dd397863e69d87719e8409342bc59c4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b7f39f5f0b8d8cc47f1126aecebb4755fe8932680f439155ab78d2197a9d3115904c0fcae8ef83c902a6f9a1600f31cff5fa81173f4554b2b35f5d92a105b8a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 14:31:04.531751) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 14:31:04.532111) ========= 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=1f5564757af27664ca02d71f000001b0-1468357753.627468-1338201030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004472 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 14:31:04.614902) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 14:31:04.615221) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 14:31:04.615519) ========= ========= Total master_lag: 0.17 =========