builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-010 starttime: 1467329418.79 results: success (0) buildid: 20160630133123 builduid: 3d3cdada0c264602875780d2d302e6be revision: 7339ed5e03791159421bc91995ebc7160d4976b2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 16:30:18.785648) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 16:30:18.786158) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 16:30:18.786456) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 16:30:18.802507) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 16:30:18.802956) ========= 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=eca2ab57546de7b41f256b19000001ef-1467329299.750888-955130584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-30 16:30:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2016-06-30 16:30:19 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119382 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 16:30:18.937397) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 16:30:18.937791) ========= 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=eca2ab57546de7b41f256b19000001ef-1467329299.750888-955130584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013872 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 16:30:18.988544) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 16:30:18.988919) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 7339ed5e03791159421bc91995ebc7160d4976b2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 7339ed5e03791159421bc91995ebc7160d4976b2 --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=eca2ab57546de7b41f256b19000001ef-1467329299.750888-955130584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-30 16:30:19,440 truncating revision to first 12 chars 2016-06-30 16:30:19,440 Setting DEBUG logging. 2016-06-30 16:30:19,440 attempt 1/10 2016-06-30 16:30:19,440 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/7339ed5e0379?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-30 16:30:19,867 unpacking tar archive at: mozilla-inbound-7339ed5e0379/testing/mozharness/ program finished with exit code 0 elapsedTime=0.795075 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 16:30:19.798855) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 16:30:19.799164) ========= script_repo_revision: 7339ed5e03791159421bc91995ebc7160d4976b2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 16:30:19.799588) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 16:30:19.799879) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 16:30:19.810846) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-06-30 16:30:19.811209) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=eca2ab57546de7b41f256b19000001ef-1467329299.750888-955130584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:30:20 INFO - MultiFileLogger online at 20160630 16:30:20 in /builds/slave/test 16:30:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 16:30:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:30:20 INFO - {'append_to_log': False, 16:30:20 INFO - 'base_work_dir': '/builds/slave/test', 16:30:20 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 16:30:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:30:20 INFO - 'branch': 'Mozilla-Inbound', 16:30:20 INFO - 'buildbot_json_path': 'buildprops.json', 16:30:20 INFO - 'config_files': ('talos/linux_config.py',), 16:30:20 INFO - 'default_actions': ('clobber', 16:30:20 INFO - 'read-buildbot-config', 16:30:20 INFO - 'download-and-extract', 16:30:20 INFO - 'populate-webroot', 16:30:20 INFO - 'create-virtualenv', 16:30:20 INFO - 'install', 16:30:20 INFO - 'run-tests'), 16:30:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:30:20 INFO - 'download_minidump_stackwalk': True, 16:30:20 INFO - 'download_symbols': 'ondemand', 16:30:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:30:20 INFO - 'tooltool.py': '/tools/tooltool.py', 16:30:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:30:20 INFO - '/tools/misc-python/virtualenv.py')}, 16:30:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:30:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:30:20 INFO - 'installer_path': 'installer.exe', 16:30:20 INFO - 'log_level': 'info', 16:30:20 INFO - 'log_name': 'talos', 16:30:20 INFO - 'log_to_console': True, 16:30:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:30:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:30:20 INFO - 'opt_config_files': (), 16:30:20 INFO - 'pip_index': False, 16:30:20 INFO - 'sps_profile': False, 16:30:20 INFO - 'sps_profile_interval': 0, 16:30:20 INFO - 'suite': 'dromaeojs-e10s', 16:30:20 INFO - 'system_bits': '32', 16:30:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:30:20 INFO - 'title': 'talos-linux64-ix-010', 16:30:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:30:20 INFO - 'use_talos_json': True, 16:30:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:30:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:30:20 INFO - 'work_dir': 'build'} 16:30:20 INFO - ##### 16:30:20 INFO - ##### Running clobber step. 16:30:20 INFO - ##### 16:30:20 INFO - Running pre-action listener: _resource_record_pre_action 16:30:20 INFO - Running main action method: clobber 16:30:20 INFO - rmtree: /builds/slave/test/build 16:30:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:30:20 INFO - Running post-action listener: _resource_record_post_action 16:30:20 INFO - ##### 16:30:20 INFO - ##### Finished clobber step (success) 16:30:20 INFO - ##### 16:30:20 INFO - ##### 16:30:20 INFO - ##### Running read-buildbot-config step. 16:30:20 INFO - ##### 16:30:20 INFO - Running pre-action listener: _resource_record_pre_action 16:30:20 INFO - Running main action method: read_buildbot_config 16:30:20 INFO - Using buildbot properties: 16:30:20 INFO - { 16:30:20 INFO - "project": "", 16:30:20 INFO - "product": "firefox", 16:30:20 INFO - "script_repo_revision": "production", 16:30:20 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 16:30:20 INFO - "repository": "", 16:30:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 16:30:20 INFO - "buildid": "20160630133123", 16:30:20 INFO - "pgo_build": "True", 16:30:20 INFO - "basedir": "/builds/slave/test", 16:30:20 INFO - "buildnumber": 935, 16:30:20 INFO - "slavename": "talos-linux64-ix-010", 16:30:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:30:20 INFO - "platform": "ubuntu64_hw", 16:30:20 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 16:30:20 INFO - "branch": "mozilla-inbound", 16:30:20 INFO - "repo_path": "integration/mozilla-inbound", 16:30:20 INFO - "revision": "7339ed5e03791159421bc91995ebc7160d4976b2", 16:30:20 INFO - "stage_platform": "linux64-pgo", 16:30:20 INFO - "builduid": "3d3cdada0c264602875780d2d302e6be", 16:30:20 INFO - "slavebuilddir": "test" 16:30:20 INFO - } 16:30:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 16:30:20 INFO - Running post-action listener: _resource_record_post_action 16:30:20 INFO - ##### 16:30:20 INFO - ##### Finished read-buildbot-config step (success) 16:30:20 INFO - ##### 16:30:20 INFO - ##### 16:30:20 INFO - ##### Running download-and-extract step. 16:30:20 INFO - ##### 16:30:20 INFO - Running pre-action listener: _resource_record_pre_action 16:30:20 INFO - Running main action method: download_and_extract 16:30:20 INFO - mkdir: /builds/slave/test/build/tests 16:30:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:30:20 INFO - https://queue.taskcluster.net/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:30:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:30:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:30:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ihja5NHIRDai3GQ65Ldyfw/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 16:30:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ihja5NHIRDai3GQ65Ldyfw/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 16:30:28 INFO - Downloaded 1361 bytes. 16:30:28 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:30:28 INFO - Using the following test package requirements: 16:30:28 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:30:28 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:30:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:30:28 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:30:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:30:28 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:30:28 INFO - u'jsshell-linux-x86_64.zip'], 16:30:28 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:30:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:30:28 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:30:28 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:30:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:30:28 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:30:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:30:28 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:30:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:30:28 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:30:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:30:28 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:30:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:30:28 INFO - https://queue.taskcluster.net/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:30:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:30:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:30:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ihja5NHIRDai3GQ65Ldyfw/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 16:30:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ihja5NHIRDai3GQ65Ldyfw/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 16:30:34 INFO - Downloaded 24270357 bytes. 16:30:34 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'] 16:30:34 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 16:30:35 INFO - Return code: 0 16:30:35 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 16:30: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')]} 16:30:35 INFO - https://queue.taskcluster.net/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:30:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:30:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:30:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ihja5NHIRDai3GQ65Ldyfw/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 16:30:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ihja5NHIRDai3GQ65Ldyfw/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 16:30:40 INFO - Downloaded 24270357 bytes. 16:30:40 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'] 16:30:40 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 16:30:42 INFO - Return code: 0 16:30:42 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')]} 16:30:42 INFO - https://queue.taskcluster.net/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:30:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:30:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:30:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ihja5NHIRDai3GQ65Ldyfw/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 16:30:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ihja5NHIRDai3GQ65Ldyfw/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 16:30:43 INFO - Downloaded 14405242 bytes. 16:30:43 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'] 16:30:43 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 16:30:43 INFO - Return code: 0 16:30:43 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')]} 16:30:43 INFO - https://queue.taskcluster.net/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:30:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:30:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:30:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ihja5NHIRDai3GQ65Ldyfw/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 16:30:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ihja5NHIRDai3GQ65Ldyfw/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 16:30:45 INFO - Downloaded 60316065 bytes. 16:30:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:30:45 INFO - mkdir: /builds/slave/test/properties 16:30:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:30:45 INFO - Writing to file /builds/slave/test/properties/build_url 16:30:45 INFO - Contents: 16:30:45 INFO - build_url:https://queue.taskcluster.net/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:30:46 INFO - Running post-action listener: _resource_record_post_action 16:30:46 INFO - Running post-action listener: set_extra_try_arguments 16:30:46 INFO - ##### 16:30:46 INFO - ##### Finished download-and-extract step (success) 16:30:46 INFO - ##### 16:30:46 INFO - ##### 16:30:46 INFO - ##### Running populate-webroot step. 16:30:46 INFO - ##### 16:30:46 INFO - Running pre-action listener: _resource_record_pre_action 16:30:46 INFO - Running main action method: populate_webroot 16:30:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:30:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:30:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:30:46 INFO - '--tppagecycles', 16:30:46 INFO - '7'], 16:30:46 INFO - 'tests': ['tsvgm']}}, 16:30:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:30:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:30:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:30:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:30:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:30:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:30:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:30:46 INFO - 'talos_options': ['--disable-e10s'], 16:30:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:30:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:30:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:30:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:30:46 INFO - 'talos_options': ['--disable-e10s'], 16:30:46 INFO - 'tests': ['damp', 'tps']}, 16:30:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:30:46 INFO - 'tests': ['damp', 'tps']}, 16:30:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:30:46 INFO - 'tests': ['dromaeo_dom']}, 16:30:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:30:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:30:46 INFO - 'tests': ['basic_compositor_video']}, 16:30:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:30:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:30:46 INFO - 'tests': ['a11yr', 16:30:46 INFO - 'ts_paint', 16:30:46 INFO - 'tpaint', 16:30:46 INFO - 'sessionrestore', 16:30:46 INFO - 'sessionrestore_no_auto_restore', 16:30:46 INFO - 'tabpaint']}, 16:30:46 INFO - 'other-e10s': {'tests': ['a11yr', 16:30:46 INFO - 'ts_paint', 16:30:46 INFO - 'tpaint', 16:30:46 INFO - 'sessionrestore', 16:30:46 INFO - 'sessionrestore_no_auto_restore', 16:30:46 INFO - 'tabpaint']}, 16:30:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:30:46 INFO - 'ts_paint', 16:30:46 INFO - 'tpaint', 16:30:46 INFO - 'sessionrestore', 16:30:46 INFO - 'sessionrestore_no_auto_restore', 16:30:46 INFO - 'tabpaint']}, 16:30:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:30:46 INFO - 'ts_paint', 16:30:46 INFO - 'tpaint', 16:30:46 INFO - 'sessionrestore', 16:30:46 INFO - 'sessionrestore_no_auto_restore', 16:30:46 INFO - 'tabpaint']}, 16:30:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:30:46 INFO - 'tests': ['a11yr', 16:30:46 INFO - 'ts_paint', 16:30:46 INFO - 'tpaint', 16:30:46 INFO - 'sessionrestore', 16:30:46 INFO - 'sessionrestore_no_auto_restore', 16:30:46 INFO - 'tabpaint']}, 16:30:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:30:46 INFO - 'tests': ['a11yr', 16:30:46 INFO - 'ts_paint', 16:30:46 INFO - 'tpaint', 16:30:46 INFO - 'sessionrestore', 16:30:46 INFO - 'sessionrestore_no_auto_restore', 16:30:46 INFO - 'tabpaint']}, 16:30:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:30:46 INFO - 'tests': ['tsvgx', 16:30:46 INFO - 'tsvgr_opacity', 16:30:46 INFO - 'tart', 16:30:46 INFO - 'tscrollx', 16:30:46 INFO - 'cart']}, 16:30:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:30:46 INFO - 'tsvgr_opacity', 16:30:46 INFO - 'tart', 16:30:46 INFO - 'tscrollx', 16:30:46 INFO - 'cart']}, 16:30:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:30:46 INFO - 'talos_options': ['--disable-e10s'], 16:30:46 INFO - 'tests': ['tp5o']}, 16:30:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:30:46 INFO - 'tests': ['tp5o']}, 16:30:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:30:46 INFO - 'talos_options': ['--disable-e10s', 16:30:46 INFO - '--xperf_path', 16:30:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:30:46 INFO - 'tests': ['tp5n']}, 16:30:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:30:46 INFO - 'talos_options': ['--xperf_path', 16:30:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:30:46 INFO - 'tests': ['tp5n']}}, 16:30:46 INFO - 'talos.zip': {'path': '', 16:30:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:30:46 INFO - Running post-action listener: _resource_record_post_action 16:30:46 INFO - ##### 16:30:46 INFO - ##### Finished populate-webroot step (success) 16:30:46 INFO - ##### 16:30:46 INFO - ##### 16:30:46 INFO - ##### Running create-virtualenv step. 16:30:46 INFO - ##### 16:30:46 INFO - Running pre-action listener: _resource_record_pre_action 16:30:46 INFO - Running main action method: create_virtualenv 16:30:46 INFO - Creating virtualenv /builds/slave/test/build/venv 16:30:46 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 16:30:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:30:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:30:46 INFO - Using real prefix '/usr' 16:30:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:30:46 INFO - Installing distribute.............................................................................................................................................................................................done. 16:30:48 INFO - Installing pip.................done. 16:30:48 INFO - Return code: 0 16:30:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:30:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:30:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:48 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 0x11ae030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13dd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146c570>, '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 0x146d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146d900>, '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': 'eca2ab57546de7b41f256b19000001ef-1467329299.750888-955130584', '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 16:30:48 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 16:30:48 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 16:30:48 INFO - Using env: {'DISPLAY': ':0', 16:30:48 INFO - 'HOME': '/home/cltbld', 16:30:48 INFO - 'LANG': 'en_US.UTF-8', 16:30:48 INFO - 'LANGUAGE': 'en_US:en', 16:30:48 INFO - 'LOGNAME': 'cltbld', 16:30:48 INFO - 'MAIL': '/var/mail/cltbld', 16:30:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:48 INFO - 'MOZ_NO_REMOTE': '1', 16:30:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:48 INFO - 'NO_EM_RESTART': '1', 16:30:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:48 INFO - 'PWD': '/builds/slave/test', 16:30:48 INFO - 'SHELL': '/bin/bash', 16:30:48 INFO - 'SHLVL': '1', 16:30:48 INFO - 'TERM': 'linux', 16:30:48 INFO - 'TMOUT': '86400', 16:30:48 INFO - 'USER': 'cltbld', 16:30:48 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1467329299.750888-955130584', 16:30:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:48 INFO - '_': '/tools/buildbot/bin/python'} 16:30:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:48 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 16:30:48 INFO - Cleaning up... 16:30:48 INFO - Return code: 0 16:30:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:30:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:30:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:48 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 0x11ae030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13dd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146c570>, '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 0x146d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146d900>, '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': 'eca2ab57546de7b41f256b19000001ef-1467329299.750888-955130584', '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 16:30:48 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 16:30:48 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 16:30:48 INFO - Using env: {'DISPLAY': ':0', 16:30:48 INFO - 'HOME': '/home/cltbld', 16:30:48 INFO - 'LANG': 'en_US.UTF-8', 16:30:48 INFO - 'LANGUAGE': 'en_US:en', 16:30:48 INFO - 'LOGNAME': 'cltbld', 16:30:48 INFO - 'MAIL': '/var/mail/cltbld', 16:30:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:48 INFO - 'MOZ_NO_REMOTE': '1', 16:30:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:48 INFO - 'NO_EM_RESTART': '1', 16:30:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:48 INFO - 'PWD': '/builds/slave/test', 16:30:48 INFO - 'SHELL': '/bin/bash', 16:30:48 INFO - 'SHLVL': '1', 16:30:48 INFO - 'TERM': 'linux', 16:30:48 INFO - 'TMOUT': '86400', 16:30:48 INFO - 'USER': 'cltbld', 16:30:48 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1467329299.750888-955130584', 16:30:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:48 INFO - '_': '/tools/buildbot/bin/python'} 16:30:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:49 INFO - Downloading/unpacking psutil>=3.1.1 16:30: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 16:30: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 16:30: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 16:30: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 16:30: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 16:30: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 16:30:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:30:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:30:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:30:51 INFO - Installing collected packages: psutil 16:30:51 INFO - Running setup.py install for psutil 16:30:51 INFO - building 'psutil._psutil_linux' extension 16:30:51 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 16:30:51 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 16:30:51 INFO - building 'psutil._psutil_posix' extension 16:30:51 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 16:30:51 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 16:30:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:30:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:30:51 INFO - Successfully installed psutil 16:30:51 INFO - Cleaning up... 16:30:51 INFO - Return code: 0 16:30:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:30:51 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')]} 16:30:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:51 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')]} 16:30:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:51 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 0x11ae030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13dd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146c570>, '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 0x146d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146d900>, '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': 'eca2ab57546de7b41f256b19000001ef-1467329299.750888-955130584', '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 16:30:51 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 16:30:51 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 16:30:51 INFO - Using env: {'DISPLAY': ':0', 16:30:51 INFO - 'HOME': '/home/cltbld', 16:30:51 INFO - 'LANG': 'en_US.UTF-8', 16:30:51 INFO - 'LANGUAGE': 'en_US:en', 16:30:51 INFO - 'LOGNAME': 'cltbld', 16:30:51 INFO - 'MAIL': '/var/mail/cltbld', 16:30:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:51 INFO - 'MOZ_NO_REMOTE': '1', 16:30:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:51 INFO - 'NO_EM_RESTART': '1', 16:30:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:51 INFO - 'PWD': '/builds/slave/test', 16:30:51 INFO - 'SHELL': '/bin/bash', 16:30:51 INFO - 'SHLVL': '1', 16:30:51 INFO - 'TERM': 'linux', 16:30:51 INFO - 'TMOUT': '86400', 16:30:51 INFO - 'USER': 'cltbld', 16:30:51 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1467329299.750888-955130584', 16:30:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:51 INFO - '_': '/tools/buildbot/bin/python'} 16:30:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:30:51 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 16:30:51 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 16:30:51 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 16:30:51 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 16:30:51 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 16:30:51 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 16:30:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:30:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:30:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:30:53 INFO - Installing collected packages: mozsystemmonitor 16:30:53 INFO - Running setup.py install for mozsystemmonitor 16:30:54 INFO - Successfully installed mozsystemmonitor 16:30:54 INFO - Cleaning up... 16:30:54 INFO - Return code: 0 16:30:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:30: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')]} 16:30:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30: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')]} 16:30:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30: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', '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 0x11ae030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13dd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146c570>, '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 0x146d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146d900>, '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': 'eca2ab57546de7b41f256b19000001ef-1467329299.750888-955130584', '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 16:30: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:30: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 jsonschema==2.5.1 16:30:54 INFO - Using env: {'DISPLAY': ':0', 16:30:54 INFO - 'HOME': '/home/cltbld', 16:30:54 INFO - 'LANG': 'en_US.UTF-8', 16:30:54 INFO - 'LANGUAGE': 'en_US:en', 16:30:54 INFO - 'LOGNAME': 'cltbld', 16:30:54 INFO - 'MAIL': '/var/mail/cltbld', 16:30:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:54 INFO - 'MOZ_NO_REMOTE': '1', 16:30:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:54 INFO - 'NO_EM_RESTART': '1', 16:30:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:54 INFO - 'PWD': '/builds/slave/test', 16:30:54 INFO - 'SHELL': '/bin/bash', 16:30:54 INFO - 'SHLVL': '1', 16:30:54 INFO - 'TERM': 'linux', 16:30:54 INFO - 'TMOUT': '86400', 16:30:54 INFO - 'USER': 'cltbld', 16:30:54 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1467329299.750888-955130584', 16:30:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:54 INFO - '_': '/tools/buildbot/bin/python'} 16:30:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:54 INFO - Downloading/unpacking jsonschema==2.5.1 16:30: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 16:30: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 16:30: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 16:30: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 16:30: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 16:30: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 16:30:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:30:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:30: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 16:30: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 16:30: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 16:30: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 16:30: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 16:30: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 16:30:56 INFO - Downloading functools32-3.2.3-2.tar.gz 16:30:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:30:56 INFO - warning: no files found matching '*.txt' 16:30:56 INFO - no previously-included directories found matching 'build' 16:30:56 INFO - no previously-included directories found matching 'dist' 16:30:56 INFO - no previously-included directories found matching '.git*' 16:30:56 INFO - Installing collected packages: jsonschema, functools32 16:30:56 INFO - Running setup.py install for functools32 16:30:56 INFO - warning: no files found matching '*.txt' 16:30:56 INFO - no previously-included directories found matching 'build' 16:30:56 INFO - no previously-included directories found matching 'dist' 16:30:56 INFO - no previously-included directories found matching '.git*' 16:30:56 INFO - Successfully installed jsonschema functools32 16:30:56 INFO - Cleaning up... 16:30:56 INFO - Return code: 0 16:30:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:30:56 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')]} 16:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:56 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')]} 16:30:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:56 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 0x11ae030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13dd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146c570>, '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 0x146d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146d900>, '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': 'eca2ab57546de7b41f256b19000001ef-1467329299.750888-955130584', '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 16:30:56 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 16:30:56 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 16:30:56 INFO - Using env: {'DISPLAY': ':0', 16:30:56 INFO - 'HOME': '/home/cltbld', 16:30:56 INFO - 'LANG': 'en_US.UTF-8', 16:30:56 INFO - 'LANGUAGE': 'en_US:en', 16:30:56 INFO - 'LOGNAME': 'cltbld', 16:30:56 INFO - 'MAIL': '/var/mail/cltbld', 16:30:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:56 INFO - 'MOZ_NO_REMOTE': '1', 16:30:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:30:56 INFO - 'NO_EM_RESTART': '1', 16:30:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:30:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:56 INFO - 'PWD': '/builds/slave/test', 16:30:56 INFO - 'SHELL': '/bin/bash', 16:30:56 INFO - 'SHLVL': '1', 16:30:56 INFO - 'TERM': 'linux', 16:30:56 INFO - 'TMOUT': '86400', 16:30:56 INFO - 'USER': 'cltbld', 16:30:56 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1467329299.750888-955130584', 16:30:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:56 INFO - '_': '/tools/buildbot/bin/python'} 16:30:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:56 INFO - Downloading/unpacking blobuploader==1.2.4 16:30: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 16:30: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 16:30: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 16:30: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 16:30: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 16:30: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 16:30:58 INFO - Downloading blobuploader-1.2.4.tar.gz 16:30:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:30:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:30:58 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 16:30:58 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 16:30:58 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 16:30:58 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 16:30:58 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 16:30:58 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 16:30:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:30:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:30:59 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 16:30:59 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 16:30:59 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 16:30:59 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 16:30:59 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 16:30:59 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 16:30:59 INFO - Downloading docopt-0.6.1.tar.gz 16:30:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:30:59 INFO - Installing collected packages: blobuploader, requests, docopt 16:30:59 INFO - Running setup.py install for blobuploader 16:30:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:30:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:30:59 INFO - Running setup.py install for requests 16:31:00 INFO - Running setup.py install for docopt 16:31:00 INFO - Successfully installed blobuploader requests docopt 16:31:00 INFO - Cleaning up... 16:31:00 INFO - Return code: 0 16:31:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:31:00 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')]} 16:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:00 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')]} 16:31:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:00 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 0x11ae030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13dd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146c570>, '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 0x146d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146d900>, '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': 'eca2ab57546de7b41f256b19000001ef-1467329299.750888-955130584', '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 16:31:00 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 16:31:00 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 16:31:00 INFO - Using env: {'DISPLAY': ':0', 16:31:00 INFO - 'HOME': '/home/cltbld', 16:31:00 INFO - 'LANG': 'en_US.UTF-8', 16:31:00 INFO - 'LANGUAGE': 'en_US:en', 16:31:00 INFO - 'LOGNAME': 'cltbld', 16:31:00 INFO - 'MAIL': '/var/mail/cltbld', 16:31:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:00 INFO - 'MOZ_NO_REMOTE': '1', 16:31:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:00 INFO - 'NO_EM_RESTART': '1', 16:31:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:00 INFO - 'PWD': '/builds/slave/test', 16:31:00 INFO - 'SHELL': '/bin/bash', 16:31:00 INFO - 'SHLVL': '1', 16:31:00 INFO - 'TERM': 'linux', 16:31:00 INFO - 'TMOUT': '86400', 16:31:00 INFO - 'USER': 'cltbld', 16:31:00 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1467329299.750888-955130584', 16:31:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:00 INFO - '_': '/tools/buildbot/bin/python'} 16:31:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:31:00 INFO - Running setup.py (path:/tmp/pip-WB1IrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:31:00 INFO - Running setup.py (path:/tmp/pip-fifxRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:31:00 INFO - Running setup.py (path:/tmp/pip-3ES8oG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:31:00 INFO - Running setup.py (path:/tmp/pip-RMRQv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:31:00 INFO - Running setup.py (path:/tmp/pip-uQzUO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:31:00 INFO - Running setup.py (path:/tmp/pip-ymQMH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:31:00 INFO - Running setup.py (path:/tmp/pip-1MiFQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:31:00 INFO - Running setup.py (path:/tmp/pip-Q2_txK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:31:00 INFO - Running setup.py (path:/tmp/pip-BgFsad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:31:01 INFO - Running setup.py (path:/tmp/pip-m6zHQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:31:01 INFO - Running setup.py (path:/tmp/pip-fqeBei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:31:01 INFO - Running setup.py (path:/tmp/pip-JDU16a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:31:01 INFO - Running setup.py (path:/tmp/pip-cr1Uzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:31:01 INFO - Running setup.py (path:/tmp/pip-g8Yrir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:31:01 INFO - Running setup.py (path:/tmp/pip-GybzVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:31:01 INFO - Running setup.py (path:/tmp/pip-7gCtFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:31:01 INFO - Running setup.py (path:/tmp/pip-aIfBNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:31:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:31:01 INFO - Running setup.py install for manifestparser 16:31:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:31:01 INFO - Running setup.py install for mozcrash 16:31:01 INFO - Running setup.py install for mozdebug 16:31:01 INFO - Running setup.py install for mozdevice 16:31:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:31:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:31:02 INFO - Running setup.py install for mozfile 16:31:02 INFO - Running setup.py install for mozhttpd 16:31:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:31:02 INFO - Running setup.py install for mozinfo 16:31:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:31:02 INFO - Running setup.py install for mozInstall 16:31:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:31:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:31:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:31:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:31:02 INFO - Running setup.py install for mozleak 16:31:02 INFO - Running setup.py install for mozlog 16:31:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:31:02 INFO - Running setup.py install for moznetwork 16:31:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:31:02 INFO - Running setup.py install for mozprocess 16:31:02 INFO - Running setup.py install for mozprofile 16:31:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:31:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:31:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:31:03 INFO - Running setup.py install for mozrunner 16:31:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:31:03 INFO - Running setup.py install for mozscreenshot 16:31:03 INFO - Running setup.py install for moztest 16:31:03 INFO - Running setup.py install for mozversion 16:31:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:31:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:31:03 INFO - Cleaning up... 16:31:03 INFO - Return code: 0 16:31:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:31:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:03 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 0x11ae030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13dd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146c570>, '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 0x146d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146d900>, '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': 'eca2ab57546de7b41f256b19000001ef-1467329299.750888-955130584', '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 16:31:03 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 16:31:03 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 16:31:03 INFO - Using env: {'DISPLAY': ':0', 16:31:03 INFO - 'HOME': '/home/cltbld', 16:31:03 INFO - 'LANG': 'en_US.UTF-8', 16:31:03 INFO - 'LANGUAGE': 'en_US:en', 16:31:03 INFO - 'LOGNAME': 'cltbld', 16:31:03 INFO - 'MAIL': '/var/mail/cltbld', 16:31:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:03 INFO - 'MOZ_NO_REMOTE': '1', 16:31:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:03 INFO - 'NO_EM_RESTART': '1', 16:31:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:03 INFO - 'PWD': '/builds/slave/test', 16:31:03 INFO - 'SHELL': '/bin/bash', 16:31:03 INFO - 'SHLVL': '1', 16:31:03 INFO - 'TERM': 'linux', 16:31:03 INFO - 'TMOUT': '86400', 16:31:03 INFO - 'USER': 'cltbld', 16:31:03 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1467329299.750888-955130584', 16:31:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:03 INFO - '_': '/tools/buildbot/bin/python'} 16:31:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:31:03 INFO - Running setup.py (path:/tmp/pip-dsmX7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:31:03 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)) 16:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:31:03 INFO - Running setup.py (path:/tmp/pip-seB15J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:31:03 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)) 16:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:31:03 INFO - Running setup.py (path:/tmp/pip-zOgV6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:31:03 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)) 16:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:31:03 INFO - Running setup.py (path:/tmp/pip-kAcuM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:31:03 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)) 16:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:31:03 INFO - Running setup.py (path:/tmp/pip-2alPmX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:31:04 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)) 16:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:31:04 INFO - Running setup.py (path:/tmp/pip-BIU3GF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:31:04 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)) 16:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:31:04 INFO - Running setup.py (path:/tmp/pip-Oz2soy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:31:04 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)) 16:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:31:04 INFO - Running setup.py (path:/tmp/pip-t6BohB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:31:04 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)) 16:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:31:04 INFO - Running setup.py (path:/tmp/pip-3hVsM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:31:04 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)) 16:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:31:04 INFO - Running setup.py (path:/tmp/pip-R2DVWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:31:04 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)) 16:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:31:04 INFO - Running setup.py (path:/tmp/pip-pOTGkq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:31:04 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)) 16:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:31:04 INFO - Running setup.py (path:/tmp/pip-Z7s7pf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:31:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:31:04 INFO - Running setup.py (path:/tmp/pip-WEYF80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:31:04 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)) 16:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:31:04 INFO - Running setup.py (path:/tmp/pip-_jijtn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:31:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:31:04 INFO - Running setup.py (path:/tmp/pip-fIUfXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:31:04 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)) 16:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:31:04 INFO - Running setup.py (path:/tmp/pip-Og37Oz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:31:04 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)) 16:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:31:04 INFO - Running setup.py (path:/tmp/pip-irIrCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:31:04 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)) 16:31:04 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)) 16:31:04 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)) 16:31:04 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)) 16:31:04 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)) 16:31:04 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)) 16:31:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:31:04 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 16:31:04 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 16:31:04 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 16:31:04 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 16:31:04 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 16:31:04 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 16:31:06 INFO - Downloading blessings-1.6.tar.gz 16:31:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:31:06 INFO - Installing collected packages: blessings 16:31:06 INFO - Running setup.py install for blessings 16:31:07 INFO - Successfully installed blessings 16:31:07 INFO - Cleaning up... 16:31:07 INFO - Return code: 0 16:31:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:31:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:31:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:31:07 INFO - Reading from file tmpfile_stdout 16:31:07 INFO - Current package versions: 16:31:07 INFO - argparse == 1.2.1 16:31:07 INFO - blessings == 1.6 16:31:07 INFO - blobuploader == 1.2.4 16:31:07 INFO - docopt == 0.6.1 16:31:07 INFO - functools32 == 3.2.3-2 16:31:07 INFO - jsonschema == 2.5.1 16:31:07 INFO - manifestparser == 1.1 16:31:07 INFO - mozInstall == 1.12 16:31:07 INFO - mozcrash == 0.17 16:31:07 INFO - mozdebug == 0.1 16:31:07 INFO - mozdevice == 0.48 16:31:07 INFO - mozfile == 1.2 16:31:07 INFO - mozhttpd == 0.7 16:31:07 INFO - mozinfo == 0.9 16:31:07 INFO - mozleak == 0.1 16:31:07 INFO - mozlog == 3.2 16:31:07 INFO - moznetwork == 0.27 16:31:07 INFO - mozprocess == 0.22 16:31:07 INFO - mozprofile == 0.28 16:31:07 INFO - mozrunner == 6.11 16:31:07 INFO - mozscreenshot == 0.1 16:31:07 INFO - mozsystemmonitor == 0.3 16:31:07 INFO - moztest == 0.7 16:31:07 INFO - mozversion == 1.4 16:31:07 INFO - psutil == 3.1.1 16:31:07 INFO - requests == 1.2.3 16:31:07 INFO - wsgiref == 0.1.2 16:31:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:31:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:07 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 0x11ae030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13dd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146c570>, '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 0x146d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146d900>, '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': 'eca2ab57546de7b41f256b19000001ef-1467329299.750888-955130584', '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 16:31:07 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 16:31:07 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 16:31:07 INFO - Using env: {'DISPLAY': ':0', 16:31:07 INFO - 'HOME': '/home/cltbld', 16:31:07 INFO - 'LANG': 'en_US.UTF-8', 16:31:07 INFO - 'LANGUAGE': 'en_US:en', 16:31:07 INFO - 'LOGNAME': 'cltbld', 16:31:07 INFO - 'MAIL': '/var/mail/cltbld', 16:31:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:07 INFO - 'MOZ_NO_REMOTE': '1', 16:31:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:07 INFO - 'NO_EM_RESTART': '1', 16:31:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:07 INFO - 'PWD': '/builds/slave/test', 16:31:07 INFO - 'SHELL': '/bin/bash', 16:31:07 INFO - 'SHLVL': '1', 16:31:07 INFO - 'TERM': 'linux', 16:31:07 INFO - 'TMOUT': '86400', 16:31:07 INFO - 'USER': 'cltbld', 16:31:07 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1467329299.750888-955130584', 16:31:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:07 INFO - '_': '/tools/buildbot/bin/python'} 16:31:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:07 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)) 16:31:07 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)) 16:31:07 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)) 16:31:07 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)) 16:31:07 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)) 16:31:07 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)) 16:31:07 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)) 16:31:07 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)) 16:31:07 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)) 16:31:07 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)) 16:31:07 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)) 16:31:07 INFO - Cleaning up... 16:31:07 INFO - Return code: 0 16:31:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:31:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ae030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13dd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146c570>, '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 0x146d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146d900>, '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': 'eca2ab57546de7b41f256b19000001ef-1467329299.750888-955130584', '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 16:31:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:31:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:31:07 INFO - Using env: {'DISPLAY': ':0', 16:31:07 INFO - 'HOME': '/home/cltbld', 16:31:07 INFO - 'LANG': 'en_US.UTF-8', 16:31:07 INFO - 'LANGUAGE': 'en_US:en', 16:31:07 INFO - 'LOGNAME': 'cltbld', 16:31:07 INFO - 'MAIL': '/var/mail/cltbld', 16:31:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:07 INFO - 'MOZ_NO_REMOTE': '1', 16:31:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:07 INFO - 'NO_EM_RESTART': '1', 16:31:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:07 INFO - 'PWD': '/builds/slave/test', 16:31:07 INFO - 'SHELL': '/bin/bash', 16:31:07 INFO - 'SHLVL': '1', 16:31:07 INFO - 'TERM': 'linux', 16:31:07 INFO - 'TMOUT': '86400', 16:31:07 INFO - 'USER': 'cltbld', 16:31:07 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1467329299.750888-955130584', 16:31:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:07 INFO - '_': '/tools/buildbot/bin/python'} 16:31:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:31:07 INFO - Cleaning up... 16:31:07 INFO - Return code: 0 16:31:07 INFO - Running post-action listener: _resource_record_post_action 16:31:07 INFO - Running post-action listener: _start_resource_monitoring 16:31:07 INFO - Starting resource monitoring. 16:31:07 INFO - ##### 16:31:07 INFO - ##### Finished create-virtualenv step (success) 16:31:07 INFO - ##### 16:31:07 INFO - ##### 16:31:07 INFO - ##### Running install step. 16:31:07 INFO - ##### 16:31:07 INFO - Running pre-action listener: _resource_record_pre_action 16:31:07 INFO - Running main action method: install 16:31:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:31:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:31:07 INFO - Reading from file tmpfile_stdout 16:31:07 INFO - Detecting whether we're running mozinstall >=1.0... 16:31:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:31:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:31:08 INFO - Reading from file tmpfile_stdout 16:31:08 INFO - Output received: 16:31:08 INFO - Usage: mozinstall [options] installer 16:31:08 INFO - Options: 16:31:08 INFO - -h, --help show this help message and exit 16:31:08 INFO - -d DEST, --destination=DEST 16:31:08 INFO - Directory to install application into. [default: 16:31:08 INFO - "/builds/slave/test"] 16:31:08 INFO - --app=APP Application being installed. [default: firefox] 16:31:08 INFO - mkdir: /builds/slave/test/build/application 16:31:08 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'] 16:31:08 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 16:31:25 INFO - Reading from file tmpfile_stdout 16:31:25 INFO - Output received: 16:31:25 INFO - /builds/slave/test/build/application/firefox/firefox 16:31:25 INFO - Running post-action listener: _resource_record_post_action 16:31:25 INFO - ##### 16:31:25 INFO - ##### Finished install step (success) 16:31:25 INFO - ##### 16:31:25 INFO - ##### 16:31:25 INFO - ##### Running run-tests step. 16:31:25 INFO - ##### 16:31:25 INFO - Running pre-action listener: _resource_record_pre_action 16:31:25 INFO - Running main action method: run_tests 16:31:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:31:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:31:25 INFO - Python 2.7.3 16:31:25 INFO - Return code: 0 16:31:25 INFO - grabbing minidump binary from tooltool 16:31:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:25 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 0x146c570>, '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 0x146d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146d900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:31:25 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 16:31:25 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 16:31:25 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 16:31:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:31:25 INFO - Return code: 0 16:31:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:31:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:31:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:31:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:31:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:31:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:31:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:31:25 INFO - Using env: {'DISPLAY': ':0', 16:31:25 INFO - 'HOME': '/home/cltbld', 16:31:25 INFO - 'LANG': 'en_US.UTF-8', 16:31:25 INFO - 'LANGUAGE': 'en_US:en', 16:31:25 INFO - 'LOGNAME': 'cltbld', 16:31:25 INFO - 'MAIL': '/var/mail/cltbld', 16:31:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:31:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:31:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:25 INFO - 'MOZ_NO_REMOTE': '1', 16:31:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:31:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:25 INFO - 'NO_EM_RESTART': '1', 16:31:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:25 INFO - 'PWD': '/builds/slave/test', 16:31:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:31:25 INFO - 'SHELL': '/bin/bash', 16:31:25 INFO - 'SHLVL': '1', 16:31:25 INFO - 'TERM': 'linux', 16:31:25 INFO - 'TMOUT': '86400', 16:31:25 INFO - 'USER': 'cltbld', 16:31:25 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1467329299.750888-955130584', 16:31:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:25 INFO - '_': '/tools/buildbot/bin/python'} 16:31:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:31:25 INFO - mozversion application_buildid: 20160630133123 16:31:25 INFO - mozversion application_changeset: 7339ed5e03791159421bc91995ebc7160d4976b2 16:31:25 INFO - mozversion application_display_name: Nightly 16:31:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:31:25 INFO - mozversion application_name: Firefox 16:31:25 INFO - mozversion application_remotingname: firefox 16:31:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:31:25 INFO - mozversion application_vendor: Mozilla 16:31:25 INFO - mozversion application_version: 50.0a1 16:31:25 INFO - mozversion platform_buildid: 20160630133123 16:31:25 INFO - mozversion platform_changeset: 7339ed5e03791159421bc91995ebc7160d4976b2 16:31:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:31:25 INFO - mozversion platform_version: 50.0a1 16:31:25 INFO - using testdate: 1467329485 16:31:25 INFO - actual date: 1467329485 16:31:25 INFO - starting webserver on 'localhost:40171' 16:31:25 INFO - SUITE-START | Running 2 tests 16:31:25 INFO - TEST-START | dromaeo_css 16:31:25 INFO - operating with platform_type : linux_ 16:31:25 INFO - Initialising browser for dromaeo_css test... 16:31:25 INFO - TEST-INFO | started process 519 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFJdxrR/profile http://localhost:40171/getInfo.html) 16:31:30 INFO - PROCESS | 519 | __metrics Screen width/height:1600/1200 16:31:30 INFO - PROCESS | 519 | colorDepth:24 16:31:30 INFO - PROCESS | 519 | Browser inner width/height: 1024/697 16:31:30 INFO - PROCESS | 519 | __metrics 16:31:31 ERROR - PROCESS | 519 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 16:31:32 INFO - TEST-INFO | 519: exit 0 16:31:32 INFO - Browser initialized. 16:31:32 INFO - Running cycle 1/1 for dromaeo_css test... 16:31:32 INFO - TEST-INFO | started process 644 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFJdxrR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:31:44 INFO - PROCESS | 644 | RSS: Main: 168300544 16:31:44 INFO - PROCESS | 644 | 16:32:33 INFO - PROCESS | 644 | 1467329553642 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] 16:34:41 INFO - PROCESS | 644 | Cycle 1(1): loaded http://localhost:40171/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40171/tests/dromaeo/cssquery-ext.html) 16:34:42 INFO - PROCESS | 644 | RSS: Main: 172085248 16:34:42 INFO - PROCESS | 644 | 16:37:45 INFO - PROCESS | 644 | Cycle 1(1): loaded http://localhost:40171/tests/dromaeo/cssquery-ext.html (next: http://localhost:40171/tests/dromaeo/cssquery-jquery.html) 16:37:45 INFO - PROCESS | 644 | RSS: Main: 168779776 16:37:45 INFO - PROCESS | 644 | 16:40:47 INFO - PROCESS | 644 | Cycle 1(1): loaded http://localhost:40171/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40171/tests/dromaeo/cssquery-mootools.html) 16:40:48 INFO - PROCESS | 644 | RSS: Main: 172470272 16:40:48 INFO - PROCESS | 644 | 16:43:49 INFO - PROCESS | 644 | Cycle 1(1): loaded http://localhost:40171/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40171/tests/dromaeo/cssquery-prototype.html) 16:43:50 INFO - PROCESS | 644 | RSS: Main: 167239680 16:43:50 INFO - PROCESS | 644 | 16:46:53 INFO - PROCESS | 644 | Cycle 1(1): loaded http://localhost:40171/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40171/tests/dromaeo/cssquery-yui.html) 16:46:53 INFO - PROCESS | 644 | RSS: Main: 169578496 16:46:53 INFO - PROCESS | 644 | 16:49:56 INFO - PROCESS | 644 | Cycle 1(1): loaded http://localhost:40171/tests/dromaeo/cssquery-yui.html (next: http://localhost:40171/tests/dromaeo/cssquery-dojo.html) 16:49:56 INFO - PROCESS | 644 | RSS: Main: 170332160 16:49:56 INFO - PROCESS | 644 | 16:49:56 INFO - PROCESS | 644 | __start_tp_report 16:49:56 INFO - PROCESS | 644 | _x_x_mozilla_page_load 16:49:56 INFO - PROCESS | 644 | _x_x_mozilla_page_load_details 16:49:56 INFO - PROCESS | 644 | |i|pagename|runs| 16:49:56 INFO - PROCESS | 644 | |0;dojo.html;3149.590553228081;3162.557241986121;3199.4081094997437;3207.631122420922;3217.5978002749644;5381;5518.503334699876;5537.390887002426;5542.1132618781;5553.666779993203;5456.727163641822;5505.559555235582;5509.228707980876;5516.558675305976;5590.664560126395;4884.926726099103;4912.7297998610065;5021.347224860763;5084.898302033957;5118.769655365499;815.2578765172434;4915.213565829468;4919.508049195069;4924.2121260598315;5049.64652474327;4957.776900039471;4959.107360675077;4965.900681986358;4974.77613507393;4996.950030499721;5011.599072074262;5014.724190169539;5026;5039.924401133986;5040.36995375578;4860.611151107938;4918.3360246367;4962.454130045692;4983.302337672729;5010.674306170087;5453.345598528163;5570.080936645449;5590.413006634326;5591.217229587861;5616.129499927518;5721.5708821838525;5870.853228669274;5882.499987501024;5905.645661260338;5912.586118971673;5936.910946335808;5996.610220335664;6022.608530445551;6024.397560243984;6065.909011364833;5560.638558493725;5562.499375056183;5568.053430916754;5570.86072848178;5577.386487486373;6024.548158888101;6081.452669259788;6081.5742897996715;6095.542834287447;6111.663858487737;5789;5836.299644042742;5843.649381037151;5860.033094539353;5863.970680146572;5923.466887980103;6022.879542409128;6031.065184896348;6031.2159419276095;6043.7280322385595;5853.0635098384055;5887.558433117533;5968.7015649217365;6019.578629495893;6035.909461358083;5941.079132734433;5952.10718392236;5953.732082056318;5981.461668449861;6037.698115094316;4489.506154323022;4491.775411229491;4500.594946454769;4504.3919070925;4520.095980803852;3889.0666240102173;3943.408488726714;3981.3231750602467;3986.421968814506;4003.199360127928;5626.324841019104;5643.266375371258;5677.233573467612;5689.146628005832;5708.828735137952;5998.1002849572915;6003.189569408074;6006;6013.729382177812;6016.939830601726;5472.179173123984;5552.472515111058;5568.693721845257;5588.497035266845;5726.226959360516;4918.754062296871;4933.925991110136;4949.876253093701;4971.602271818246;4975.776090075955;6082.330943596201;6085.66528840918;6088.786892458743;6099.634021958696;6131.448169664752;5821.534277257724;5873.148393482836;5886.646801191857;5894.882102358015;5952.285725712942;6137.907931380943;6188.504919606331;6188.907166392598;6210;6222.0355844844125;5932.673702946379;5938.881222375442;5944.940550594439;5945.970270148621;5960.374160713062;5784.045632470596;5925.733341999534;5951.1073338999495;5971.253593300838;6007.098935159761;5829.8251052468495;5849.94150058494;5861.589688721749;5864.384239654945;5878.970605146947;5795.8551036224435;5825.0679891217205;5835.766569337179;5835.912461313169;5840.649561026352;5538.833834984957;5662.2639056922335;5683.9715801420725;5756.366799652119;5806.2451881255165;5811.418858114154;5864.120381942743;5909.970450147722;5915.349311575637;5920.526357891272;5552.555795536428;5780.248567686174;5785.971070144622;5792.652440853562;5794.420557944172 16:49:56 INFO - PROCESS | 644 | |1;ext.html;592.0615823919088;607.3986753114417;635.8378613453572;638.6966191059246;662.8077857421348;38897;43892.780536097314;43920.34119488202;44207;44212.90509664325;43393.56606433943;43404.56595434045;43491.782541087254;43559.78220108903;43929.12141757163;8930.106989301083;9070.183683468487;9073.36486445949;9078.727638170833;9104.63581456741;8873.29013678904;9029.0519495453;9030.819383612325;9033.457992520436;9041.864372034424;9069.501177435239;9085.091490850895;9110;9112.362134650577;9134.17792398684;8944.060873608276;8948.552572371387;9036.8644470333;9047.638094476213;9100.63597456101;8786.60460279289;8810.427322224099;8828.382013259074;8857.424267422597;8860.158284962918;42248.366274505905;42661.57338426607;42664;42755.78622106901;42774;3555.5377800885717;4129.793510324472;4240.533541310484;4249.745015299061;4257.063446041866;33695.32609347799;33875.6612433875;34160.14599635004;34240.31519369624;35239.82380088109;4414.823407063714;4575.771211439414;4679.74261415622;4688.789004494806;4728.172569800271;256345;256542;256889;257068.7146564274;258357;36531.81734091313;37463;37481.25037499235;60653.69673151606;61047.38952610506;39518.604813952064;39566.406503902464;39627.405588915615;39803.40294895579;39912;14818.481353152803;14957.775633365509;14967.176805275814;14971.251437428085;15033.849661503464;12175.756484870253;12370.690732731573;12405.379731013414;12415.875841241472;12427.130100892851;9032;9040.457572545669;9066.184043436122;9082.500462474627;9148.2681385489;3400.3199360128074;3546.6453354664327;3581.426971684518;3598.5142005829402;3602.927941441209;1046.6807623674852;1056.4823236614004;1074.9140068794477;1079.6653037558383;1120.6862078618;32977.175570610925;33029;33068.66931330656;33349.333013339594;33392.33215335728;1104.7900898829196;1120.7086157599083;1126.7633796902742;1173.9589114381126;1187.554666999875;17375.73936390955;17562.912185438992;17805.109744512723;17830.46508604744;17838.37565685195;597321;599347;602820;602883;607913;61153;61517;61666.69166654138;61694.38305616976;61709.382906170365;1329.694170340827;1360.2994457854213;1377.1668140774887;1383.75784237758;1389.9722005560034;31521.684783151875;32389.19027024343;32482.18794530061;33009.174770629965;33320.833395832866;54273.45726542684;54407;54417.72791136019;54713.452865470834;54885;440039;442955.2817887248;444077;446736;447808;29571.85214074002;30207.395852083275;30581.23546911345;30672.846635766677;30760.692393075784;43469.56530434655;43683.781581093164;44167.77916110399;44209.33685994648;44253.55746442494;42820.35769463398;43066.56933430751;43290.78354608207;43749.12501750011;45008.32487512755;42591.3611295837;43172.84135793261;43916.78041609772;44047.11905761931;44634.55365446304;42335.7883210582;43025.78487107545;43430.34854477122;43604.34593481037;45429.77285113553;35606.821965890005;38655.226895462496;38864.6113538861;39066.60933390629;39292.80353598328;28565.42869142647;28599.857000714863;28808.135755927357;28863.56704649474;28937.855310723313 16:49:56 INFO - PROCESS | 644 | |2;jquery.html;415.7734034950951;421.9240536703396;424.6581501890978;428.4494424664306;441.9071994881075;19281.71077433838;20052.99999999998;20940.16239350426;20969.161233550676;21006;19137;19463.221471141173;19905.502362440948;20007.199712011537;20502.384928452135;5255.264263003173;5447.291852059227;5457.290552228224;5462.617616766828;5464.836054918359;5403.83788486346;5450.236966824647;5480.698561579112;5650.63270887391;5947.078202878561;5822.505087067604;5886.117082437647;5900.822975310747;5942.078977758454;5948.167256584082;5899.380565040652;5907.645541267516;6487.383698548654;6780;6838.350356716104;5990.801839632048;6165.506759459233;6180.258368995749;6188.164597779332;6216.285127210338;24748.133815316378;25103.246902592953;25299.747002529923;25368.619470707956;25722;2488.751124887515;2595.1954893982925;2678.892844286226;2782.7634651054686;2995.445842519141;10809.459527023697;10986.340819550853;11020.669379918616;13599.388027538685;14251.216183109926;1833.1292635997927;1926.1043614719083;1992.1031955205005;1994.4614953962493;2077.5849684696486;87253.56373218157;91617.54191229;92530.53734731351;93588.53205733928;94619;11902.404879755977;11971.580994665319;12363.701811309684;12380.876191238152;12697.174683645533;16810.243539040774;16968.49094527166;16988.660226795393;17025.829741702673;17036.403725869535;8063.637136328879;8072.677092916218;8177.345812334999;8225.588720564068;8380.16198380157;7535.924640753522;7539.208383119803;7685.769426917202;7745.225477452323;7979.294804215014;4908.312836202935;5042.218456139304;5077.18764997606;5079.273047163982;5124.000819840096;2093.926712565053;2132.5095228097316;2148.9355319340443;2155.8167555757936;2168.7831216878503;885.5572213893054;966.3187452845727;984.0503913723292;989.5200827598609;1024.3956065921143;19244.422667320003;20317.79682203159;20322.288719894732;20405.183792648426;20435.59128817445;1020.2756043209256;1026.1739299863532;1029.6653587584065;1031.3914790273625;1080.9675709728722;10726;11317.547298108148;11450.255733377471;11483.42582870853;11525.423728813694;427141;430708;448366;451507;452509;56673.149902751495;78712;100277.49861250793;102994.48502757438;104916.47541762242;995.4326034160459;995.7809281957958;1021.8313978193663;1024.2215915903967;1032.5818043692316;17440.21519031672;18231.817681823013;18466.538336541693;18761.812381876553;18944.52638684044;43511.56488435075;48080.75959620319;48493.51506485031;48743;50178;61449;62429;62849;63782;64214.67892660507;9034.322425817958;9339.85990210161;9403.106704863027;9409.858852117086;9602.039796020343;11152.386618735723;14226.35981380861;14436.350364233846;14673.559793206221;14838;12333.321667308384;12600.369981500706;12602.274147194801;12753.171043882117;12828.486860525474;12405;12489.250644961332;12670.303133327756;12807.359632018548;12875.484980600671;12222.633321000385;12841.93579032099;12913;13065.412056457291;13172.736545269232;9048.728538143867;9067.546622668708;9086.54567271647;9183.586738596645;9203.815923681355;9276.675316364164;12294.323812190416;12381.62855114348;12385.19496232742;12600.621981340575 16:49:56 INFO - PROCESS | 644 | |3;mootools.html;1485.95542133736;1513.092144713172;1671.899686018839;1733.757273981642;1800.4508624869418;7780.533168009923;8241.670333186665;8442.91557084429;8939.865902011476;8973.057828927958;8300;8495.405321627473;8544.23101920827;8609.741707748763;8614.396992210532;2372.9881350593264;2401.5317013182434;2409.9518009639883;2411.794997425221;2414.541237164933;2376.988115059431;2379.6787433696404;2416.359664688859;2424.73327933928;2435.4885474050384;2406.097713357491;2417.2627348658652;2424.442378253003;2431.732509423962;2436.1473484280536;2337.8947947342326;2347.612643913752;2359.693239878805;2360.0441821062495;2402.003168684994;2320.2459200759654;2346.0615753698485;2352.5882970480097;2362.421206804344;2371.703537057868;8479.576021198915;8610.956945215234;8651.264642505395;8653.740387788377;8667.869981950276;5248.160294352885;5409.540189083933;5420.620556561003;5439.619226654097;5441.075017247077;3441.397755392821;3473.9131521711906;3478.1826270826336;3487.319972605343;3490.790552566829;1212.7513859658836;1212.872648371917;1213.5509861351268;1219.2562536852513;1232.2175418609158;11648.417579121095;11862.991645710124;11897.94051029748;11909.047276217969;11929.224600401032;4517.503074661785;4653.581177694024;4785.090832741837;4786.904261914742;4788.545088216614;10035.448050357301;10074.546645400975;10112.393256404492;10138.645147419953;10157.898421015696;5390.97304513475;5391.622586418913;5407.594430417735;5424.918626220609;5431.646942948775;4352.891177720519;4797.376341075638;4945;4946.282788995575;5004.9499505005215;3957.3470377387407;4045.6561192298395;4096.959030409717;4134.607212314825;4136.44158038667;1313.1923866822026;1338.5649663859285;1340.2159736554224;1351.304078399625;1359.4901911783081;1002.4236064263077;1002.6991902429243;1020.260311274335;1021.4126877045728;1029.5469993202967;5942.197803296586;5991.850203744854;6095.2685677718955;6132.938670613326;6265.655388953652;476.56156336170113;478.89943111946883;490.83557008402585;493.84937594034164;499.56537812102977;4225.9577404226175;4271.957280427218;4310.4611923509565;4329;4349.086691794695;10627.256092073481;11058.944705276583;11083.944580277048;11124.777504449865;11160.441977901073;9647.903520964841;10091.596336146471;11060.336379817236;11088.168387370979;11089.72275693098;8295.875561866576;8396.958015209884;8458.534780587126;8509.702160424355;8520.74437766868;5830.708464576839;5922.674252915958;6041.395860413923;6042.244719410074;6137.570370074052;9415.952920235355;9932;10070.14403775658;10209.132223761064;10214.438205898747;9907.702768916944;10048;10081.647142349982;10122.797544049225;10229.43738094412;6910;7370.447216458894;7596.088469383489;7596.544207347577;7739.1100023495765;8297.377696672653;8410.074891762024;8429.325653947792;8526;8530.402871798915;7525.736599219001;7687.884681729666;7716.652750626123;7834.373250139861;7855.7250496232355;7521.811954701177;7608.581528016012;7648.80877978055;7750.767476975474;7772.417068719756;6744.494162937701;6751.831204219934;6758.222804377363;6778.2205046420295;6797.6941037654415;5103.8468845934685;5237.947620523899;5262.368515777978;5369.838904832861;5470;5225;5240.397354304304;5309.681419114865;5421.376541697755;5453.890922181455 16:49:56 INFO - PROCESS | 644 | |4;prototype.html;340.45867071356554;350.3133857639027;350.93683137035333;360.89534035129816;361.35317781171705;5525;5602.943970560294;5656.745446454915;5739.483446489815;5745.195672605833;5570.526505247059;5638.126090455976;5641.802536911209;5649.378568357477;5649.46330098641;4414.29371300592;4417.249067658498;4431.711938723989;4431.844885429011;4451.731256591872;4169.811603692948;4395.494518130408;4417.4919884213405;4446.555344465543;4452.287633978564;4328.761918094504;4344.826206951718;4345.630621397185;4370.125974805036;4388.363687265361;4335.9566404335865;4337.891552711176;4362;4374.19077470669;4413.881336958278;3799.4680744695765;3857.1707082977296;3875.4574359589396;3877.3214687429586;3877.7702820877826;5473.728402712869;5475.589330800206;5514.207882438223;5528.944710552923;5577.888442231173;5047.570956468705;5076.593872490192;5079.171498260624;5080.364954380702;5096.439391666913;5792.061398249231;5965.612235204698;5987.9101813472835;5999.220101386792;6038.365971573009;4172.144710334374;4175.54069052404;4185.790710464495;4202.642775364097;4227.387028880826;6245.189664650925;6270.435660790505;6281.581591087419;6284.4344009039405;6289.465395441393;4192.496900371975;4339.153864996296;4345.391645169679;4396.340548917624;4426.26966550522;4409.2724700424715;4439.755813430293;4439.889002774892;4442.42248507692;4467.486239082482;5082.923756143661;5083.288339632454;5089.923651145235;5092.28707980883;5094.719790411563;5781.942180578225;5856.690969602161;6045.911735887495;6054.848628784228;6062.939370606326;1507.216247551267;1526.137732181314;1530.6326481644326;1533.9693206135814;1535.4702627593463;941.6939494664261;943.6649989253854;945.7351941456403;954.6229239450518;980.926430517714;4913.852584422473;5027.245913113063;5058.291839142523;5107;5135.276924229904;5390.595705322116;5410.430975017201;5419.561197461158;5427.891442171134;5443.618946673774;4962.627802914796;4989.575886049726;5003.399592048904;5024.221245706848;5156.690598564098;2853.6432945881766;2870.512012957802;2886.5525843494293;2896.3772788850497;2899.855007249629;5480.451590010664;5573.275474188411;5583.581231407661;5585.860353491195;5620.690862002547;5601.159826026129;5891.587588868738;6269.968650156811;6307.274663413675;6310.747570097236;6268.623882567061;6306.779262725782;6348.333424990402;6370.968145159337;6384.106225128486;6054.243219597551;6139.772045590989;6147.72335244924;6177.660228687465;6184.319724830355;6117.816465506042;6137.539684523589;6155.861165684362;6178.227721534809;6178.691065446799;6203.844903877439;6356.96577095325;6412;6436.517261205335;6469.350315669474;4434.667399945081;4459.754713490789;4470.955290447054;4478;4494.752788596527;5811.912821307768;5966.552508561788;6149.877002460015;6166.630002199882;6174.135621013152;5970.283565972111;6029.457348838626;6069.362716914837;6071.878562428638;6090.573659843769;5989.820305390671;6000.399960003964;6007.519398448027;6011.458968692838;6079.483243924316;5561.416051314553;5833.270841144857;5853.268341457318;5866.560007999503;5889.293284805851;5949.196858424058;6022.668753218615;6042.97269464201;6043.8186854394435;6068.271807383142;5651.2935883014625;5855.736491857791;5861.1537365729655;5866;5884.588078834612 16:49:56 INFO - PROCESS | 644 | |5;yui.html;671.1509939925992;675.4225137507434;728.2608152724983;743.7619961612282;770.2913319745833;15011;16077.919610401961;16096;16109.677806443864;16197.83802161978;14587.12477251363;14764.040337378063;14770;15105.62235944102;15197.77203341948;676.2020815437781;802.6307898366758;817.7342363731796;835.6281454752638;837.476577139288;820.6471217376526;827;828.0973738624898;828.5028982610446;830.248624994378;890.5235698901089;891.0554811899408;892.1078921078921;892.2148509311829;892.464521287229;872.8385248729005;874.2525141004445;877.368294827723;877.7366789963049;878.7846977490492;638.5147288061061;639.1690801957483;639.9648019358933;640.7565125252421;641.3778634724357;15805.762913556306;15978.920105399515;15985.44050958211;15999;16004.199790010452;15594.376224951102;15651.452199172974;15653.765193522106;15761.290741916526;15891.205439728083;12889.806652900214;12901.67745806353;12920.806187907188;13031.739365212738;13167.872461114339;3963.4649322341693;4016.3975403689387;4072.6538244249273;4126.257273690734;4210.810513526868;87831.12168878358;87878.5606071972;88585;89127.55436222778;91598.5420072902;12019.158658893968;12061.638150855488;12231.755364892651;12307.93846030782;12393.62819115428;20539.281125160847;20617.79382206189;20625.690614640793;20680.896595516926;20689.79310206909;8545.74362769118;8653.78846961426;8663.870041949376;8827.249683776823;8974.68588599409;4851.223804191312;4898.902021959612;4912.312276281252;4933.753312334441;5011.5489605935645;3434.7767395119236;3527.700145487611;3545.7517973742106;3593.94609080864;3625.655562721537;594.9940500595026;595.3510673365965;628.8836565235355;631.1857703562445;650.6226388694546;759.3811043999123;760.5778792770066;769.61134627013;769.7036640893297;785.0775338976794;10033.046860548237;10101.545430455648;10376.533056012497;10496.527656255486;10518;598.60791181776;648.6918713611092;671.8725225939463;687.2062767503542;764.0258670195434;4580.954190458119;5104.744762761847;5290.285811415487;5313.787448502017;5450;77573;123676;123836;124288;125996.37001814932;109623;110149;111727;112447;112966.43516782527;87678;90879.54560227157;93930.5303473492;95097;95408;9566.760830979281;9827.901720982985;9839.68105861394;10058.145057669888;10149.122412353738;43644;44698.77650611726;47348.52651473441;53220.2016969738;56597.43402565922;74995;76700.61649691715;77316.61341693255;77820.61089694516;82479;12999.672101827242;13158.473661053451;13384.93307533456;13618.455261789417;14083.859161408254;14588.854111459174;15406;15666;15986.360545578513;16062.357505699641;14202;14469.27653617336;14523.128612283297;14555.345009474388;14760.409583616534;14086.647833804236;14214.857851421353;14463.638409039859;14480.493182738554;14693.33879975425;14199.416816775158;14205.857941420454;14915.701685966436;14945.701085978437;15353.309101090254;11741.76516469683;11982.460789264678;12046.216995895238;12138.393080346124;12259.632211033684;10923.508442119964;10969.670909872717;11376;11611.47748351343;12490.500379985062 16:49:56 INFO - PROCESS | 644 | __end_tp_report 16:49:56 INFO - PROCESS | 644 | __start_cc_report 16:49:56 INFO - PROCESS | 644 | _x_x_mozilla_cycle_collect,355 16:49:56 INFO - PROCESS | 644 | __end_cc_report 16:49:56 INFO - PROCESS | 644 | __startTimestamp1467330596419__endTimestamp 16:49:56 INFO - PROCESS | 644 | 16:49:56 INFO - PROCESS | 644 | ------- Summary: start ------- 16:49:56 INFO - PROCESS | 644 | Number of tests: 6 16:49:56 INFO - PROCESS | 644 | 16:49:56 INFO - PROCESS | 644 | [#0] dojo.html Cycles:165 Average:5480.35 Median:5785.97 stddev:749.72 (13.0%) stddev-sans-first:729.38 16:49:56 INFO - PROCESS | 644 | Values: 3149.6 3162.6 3199.4 3207.6 3217.6 5381.0 5518.5 5537.4 5542.1 5553.7 5456.7 5505.6 5509.2 5516.6 5590.7 4884.9 4912.7 5021.3 5084.9 5118.8 815.3 4915.2 4919.5 4924.2 5049.6 4957.8 4959.1 4965.9 4974.8 4997.0 5011.6 5014.7 5026.0 5039.9 5040.4 4860.6 4918.3 4962.5 4983.3 5010.7 5453.3 5570.1 5590.4 5591.2 5616.1 5721.6 5870.9 5882.5 5905.6 5912.6 5936.9 5996.6 6022.6 6024.4 6065.9 5560.6 5562.5 5568.1 5570.9 5577.4 6024.5 6081.5 6081.6 6095.5 6111.7 5789.0 5836.3 5843.6 5860.0 5864.0 5923.5 6022.9 6031.1 6031.2 6043.7 5853.1 5887.6 5968.7 6019.6 6035.9 5941.1 5952.1 5953.7 5981.5 6037.7 4489.5 4491.8 4500.6 4504.4 4520.1 3889.1 3943.4 3981.3 3986.4 4003.2 5626.3 5643.3 5677.2 5689.1 5708.8 5998.1 6003.2 6006.0 6013.7 6016.9 5472.2 5552.5 5568.7 5588.5 5726.2 4918.8 4933.9 4949.9 4971.6 4975.8 6082.3 6085.7 6088.8 6099.6 6131.4 5821.5 5873.1 5886.6 5894.9 5952.3 6137.9 6188.5 6188.9 6210.0 6222.0 5932.7 5938.9 5944.9 5946.0 5960.4 5784.0 5925.7 5951.1 5971.3 6007.1 5829.8 5849.9 5861.6 5864.4 5879.0 5795.9 5825.1 5835.8 5835.9 5840.6 5538.8 5662.3 5684.0 5756.4 5806.2 5811.4 5864.1 5910.0 5915.3 5920.5 5552.6 5780.2 5786.0 5792.7 5794.4 16:49:56 INFO - PROCESS | 644 | 16:49:56 INFO - PROCESS | 644 | [#1] ext.html Cycles:180 Average:58963.95 Median:42797.18 stddev:121955.76 (285.0%) stddev-sans-first:122219.13 16:49:56 INFO - PROCESS | 644 | Values: 592.1 607.4 635.8 638.7 662.8 38897.0 43892.8 43920.3 44207.0 44212.9 43393.6 43404.6 43491.8 43559.8 43929.1 8930.1 9070.2 9073.4 9078.7 9104.6 8873.3 9029.1 9030.8 9033.5 9041.9 9069.5 9085.1 9110.0 9112.4 9134.2 8944.1 8948.6 9036.9 9047.6 9100.6 8786.6 8810.4 8828.4 8857.4 8860.2 42248.4 42661.6 42664.0 42755.8 42774.0 3555.5 4129.8 4240.5 4249.7 4257.1 33695.3 33875.7 34160.1 34240.3 35239.8 4414.8 4575.8 4679.7 4688.8 4728.2 256345.0 256542.0 256889.0 257068.7 258357.0 36531.8 37463.0 37481.3 60653.7 61047.4 39518.6 39566.4 39627.4 39803.4 39912.0 14818.5 14957.8 14967.2 14971.3 15033.8 12175.8 12370.7 12405.4 12415.9 12427.1 9032.0 9040.5 9066.2 9082.5 9148.3 3400.3 3546.6 3581.4 3598.5 3602.9 1046.7 1056.5 1074.9 1079.7 1120.7 32977.2 33029.0 33068.7 33349.3 33392.3 1104.8 1120.7 1126.8 1174.0 1187.6 17375.7 17562.9 17805.1 17830.5 17838.4 597321.0 599347.0 602820.0 602883.0 607913.0 61153.0 61517.0 61666.7 61694.4 61709.4 1329.7 1360.3 1377.2 1383.8 1390.0 31521.7 32389.2 32482.2 33009.2 33320.8 54273.5 54407.0 54417.7 54713.5 54885.0 440039.0 442955.3 444077.0 446736.0 447808.0 29571.9 30207.4 30581.2 30672.8 30760.7 43469.6 43683.8 44167.8 44209.3 44253.6 42820.4 43066.6 43290.8 43749.1 45008.3 42591.4 43172.8 43916.8 44047.1 44634.6 42335.8 43025.8 43430.3 43604.3 45429.8 35606.8 38655.2 38864.6 39066.6 39292.8 28565.4 28599.9 28808.1 28863.6 28937.9 16:49:56 INFO - PROCESS | 644 | 16:49:56 INFO - PROCESS | 644 | [#2] jquery.html Cycles:180 Average:28693.76 Median:25545.31 stddev:73433.42 (287.5%) stddev-sans-first:73608.72 16:49:56 INFO - PROCESS | 644 | Values: 415.8 421.9 424.7 428.4 441.9 19281.7 20053.0 20940.2 20969.2 21006.0 19137.0 19463.2 19905.5 20007.2 20502.4 5255.3 5447.3 5457.3 5462.6 5464.8 5403.8 5450.2 5480.7 5650.6 5947.1 5822.5 5886.1 5900.8 5942.1 5948.2 5899.4 5907.6 6487.4 6780.0 6838.4 5990.8 6165.5 6180.3 6188.2 6216.3 24748.1 25103.2 25299.7 25368.6 25722.0 2488.8 2595.2 2678.9 2782.8 2995.4 10809.5 10986.3 11020.7 13599.4 14251.2 1833.1 1926.1 1992.1 1994.5 2077.6 87253.6 91617.5 92530.5 93588.5 94619.0 11902.4 11971.6 12363.7 12380.9 12697.2 16810.2 16968.5 16988.7 17025.8 17036.4 8063.6 8072.7 8177.3 8225.6 8380.2 7535.9 7539.2 7685.8 7745.2 7979.3 4908.3 5042.2 5077.2 5079.3 5124.0 2093.9 2132.5 2148.9 2155.8 2168.8 885.6 966.3 984.1 989.5 1024.4 19244.4 20317.8 20322.3 20405.2 20435.6 1020.3 1026.2 1029.7 1031.4 1081.0 10726.0 11317.5 11450.3 11483.4 11525.4 427141.0 430708.0 448366.0 451507.0 452509.0 56673.1 78712.0 100277.5 102994.5 104916.5 995.4 995.8 1021.8 1024.2 1032.6 17440.2 18231.8 18466.5 18761.8 18944.5 43511.6 48080.8 48493.5 48743.0 50178.0 61449.0 62429.0 62849.0 63782.0 64214.7 9034.3 9339.9 9403.1 9409.9 9602.0 11152.4 14226.4 14436.4 14673.6 14838.0 12333.3 12600.4 12602.3 12753.2 12828.5 12405.0 12489.3 12670.3 12807.4 12875.5 12222.6 12841.9 12913.0 13065.4 13172.7 9048.7 9067.5 9086.5 9183.6 9203.8 9276.7 12294.3 12381.6 12385.2 12600.6 16:49:56 INFO - PROCESS | 644 | 16:49:56 INFO - PROCESS | 644 | [#3] mootools.html Cycles:180 Average:5782.89 Median:2632.00 stddev:3216.13 (122.2%) stddev-sans-first:3208.94 16:49:56 INFO - PROCESS | 644 | Values: 1486.0 1513.1 1671.9 1733.8 1800.5 7780.5 8241.7 8442.9 8939.9 8973.1 8300.0 8495.4 8544.2 8609.7 8614.4 2373.0 2401.5 2410.0 2411.8 2414.5 2377.0 2379.7 2416.4 2424.7 2435.5 2406.1 2417.3 2424.4 2431.7 2436.1 2337.9 2347.6 2359.7 2360.0 2402.0 2320.2 2346.1 2352.6 2362.4 2371.7 8479.6 8611.0 8651.3 8653.7 8667.9 5248.2 5409.5 5420.6 5439.6 5441.1 3441.4 3473.9 3478.2 3487.3 3490.8 1212.8 1212.9 1213.6 1219.3 1232.2 11648.4 11863.0 11897.9 11909.0 11929.2 4517.5 4653.6 4785.1 4786.9 4788.5 10035.4 10074.5 10112.4 10138.6 10157.9 5391.0 5391.6 5407.6 5424.9 5431.6 4352.9 4797.4 4945.0 4946.3 5004.9 3957.3 4045.7 4097.0 4134.6 4136.4 1313.2 1338.6 1340.2 1351.3 1359.5 1002.4 1002.7 1020.3 1021.4 1029.5 5942.2 5991.9 6095.3 6132.9 6265.7 476.6 478.9 490.8 493.8 499.6 4226.0 4272.0 4310.5 4329.0 4349.1 10627.3 11058.9 11083.9 11124.8 11160.4 9647.9 10091.6 11060.3 11088.2 11089.7 8295.9 8397.0 8458.5 8509.7 8520.7 5830.7 5922.7 6041.4 6042.2 6137.6 9416.0 9932.0 10070.1 10209.1 10214.4 9907.7 10048.0 10081.6 10122.8 10229.4 6910.0 7370.4 7596.1 7596.5 7739.1 8297.4 8410.1 8429.3 8526.0 8530.4 7525.7 7687.9 7716.7 7834.4 7855.7 7521.8 7608.6 7648.8 7750.8 7772.4 6744.5 6751.8 6758.2 6778.2 6797.7 5103.8 5237.9 5262.4 5369.8 5470.0 5225.0 5240.4 5309.7 5421.4 5453.9 16:49:56 INFO - PROCESS | 644 | 16:49:56 INFO - PROCESS | 644 | [#4] prototype.html Cycles:180 Average:4933.45 Median:5545.18 stddev:1468.86 (26.5%) stddev-sans-first:1431.96 16:49:56 INFO - PROCESS | 644 | Values: 340.5 350.3 350.9 360.9 361.4 5525.0 5602.9 5656.7 5739.5 5745.2 5570.5 5638.1 5641.8 5649.4 5649.5 4414.3 4417.2 4431.7 4431.8 4451.7 4169.8 4395.5 4417.5 4446.6 4452.3 4328.8 4344.8 4345.6 4370.1 4388.4 4336.0 4337.9 4362.0 4374.2 4413.9 3799.5 3857.2 3875.5 3877.3 3877.8 5473.7 5475.6 5514.2 5528.9 5577.9 5047.6 5076.6 5079.2 5080.4 5096.4 5792.1 5965.6 5987.9 5999.2 6038.4 4172.1 4175.5 4185.8 4202.6 4227.4 6245.2 6270.4 6281.6 6284.4 6289.5 4192.5 4339.2 4345.4 4396.3 4426.3 4409.3 4439.8 4439.9 4442.4 4467.5 5082.9 5083.3 5089.9 5092.3 5094.7 5781.9 5856.7 6045.9 6054.8 6062.9 1507.2 1526.1 1530.6 1534.0 1535.5 941.7 943.7 945.7 954.6 980.9 4913.9 5027.2 5058.3 5107.0 5135.3 5390.6 5410.4 5419.6 5427.9 5443.6 4962.6 4989.6 5003.4 5024.2 5156.7 2853.6 2870.5 2886.6 2896.4 2899.9 5480.5 5573.3 5583.6 5585.9 5620.7 5601.2 5891.6 6270.0 6307.3 6310.7 6268.6 6306.8 6348.3 6371.0 6384.1 6054.2 6139.8 6147.7 6177.7 6184.3 6117.8 6137.5 6155.9 6178.2 6178.7 6203.8 6357.0 6412.0 6436.5 6469.4 4434.7 4459.8 4471.0 4478.0 4494.8 5811.9 5966.6 6149.9 6166.6 6174.1 5970.3 6029.5 6069.4 6071.9 6090.6 5989.8 6000.4 6007.5 6011.5 6079.5 5561.4 5833.3 5853.3 5866.6 5889.3 5949.2 6022.7 6043.0 6043.8 6068.3 5651.3 5855.7 5861.2 5866.0 5884.6 16:49:56 INFO - PROCESS | 644 | 16:49:56 INFO - PROCESS | 644 | [#5] yui.html Cycles:180 Average:22023.04 Median:3794.56 stddev:32136.17 (846.9%) stddev-sans-first:32186.33 16:49:56 INFO - PROCESS | 644 | Values: 671.2 675.4 728.3 743.8 770.3 15011.0 16077.9 16096.0 16109.7 16197.8 14587.1 14764.0 14770.0 15105.6 15197.8 676.2 802.6 817.7 835.6 837.5 820.6 827.0 828.1 828.5 830.2 890.5 891.1 892.1 892.2 892.5 872.8 874.3 877.4 877.7 878.8 638.5 639.2 640.0 640.8 641.4 15805.8 15978.9 15985.4 15999.0 16004.2 15594.4 15651.5 15653.8 15761.3 15891.2 12889.8 12901.7 12920.8 13031.7 13167.9 3963.5 4016.4 4072.7 4126.3 4210.8 87831.1 87878.6 88585.0 89127.6 91598.5 12019.2 12061.6 12231.8 12307.9 12393.6 20539.3 20617.8 20625.7 20680.9 20689.8 8545.7 8653.8 8663.9 8827.2 8974.7 4851.2 4898.9 4912.3 4933.8 5011.5 3434.8 3527.7 3545.8 3593.9 3625.7 595.0 595.4 628.9 631.2 650.6 759.4 760.6 769.6 769.7 785.1 10033.0 10101.5 10376.5 10496.5 10518.0 598.6 648.7 671.9 687.2 764.0 4581.0 5104.7 5290.3 5313.8 5450.0 77573.0 123676.0 123836.0 124288.0 125996.4 109623.0 110149.0 111727.0 112447.0 112966.4 87678.0 90879.5 93930.5 95097.0 95408.0 9566.8 9827.9 9839.7 10058.1 10149.1 43644.0 44698.8 47348.5 53220.2 56597.4 74995.0 76700.6 77316.6 77820.6 82479.0 12999.7 13158.5 13384.9 13618.5 14083.9 14588.9 15406.0 15666.0 15986.4 16062.4 14202.0 14469.3 14523.1 14555.3 14760.4 14086.6 14214.9 14463.6 14480.5 14693.3 14199.4 14205.9 14915.7 14945.7 15353.3 11741.8 11982.5 12046.2 12138.4 12259.6 10923.5 10969.7 11376.0 11611.5 12490.5 16:49:56 INFO - PROCESS | 644 | -------- Summary: end -------- 16:49:56 INFO - PROCESS | 644 | 16:49:57 INFO - TEST-INFO | 644: exit 0 16:49:57 INFO - TEST-OK | dromaeo_css | took 1111717ms 16:49:57 INFO - TEST-START | kraken 16:49:57 INFO - operating with platform_type : linux_ 16:49:57 INFO - Initialising browser for kraken test... 16:49:57 INFO - TEST-INFO | started process 908 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7A1xEe/profile http://localhost:40171/getInfo.html) 16:50:02 INFO - PROCESS | 908 | __metrics Screen width/height:1600/1200 16:50:02 INFO - PROCESS | 908 | colorDepth:24 16:50:02 INFO - PROCESS | 908 | Browser inner width/height: 1024/697 16:50:02 INFO - PROCESS | 908 | __metrics 16:50:03 ERROR - PROCESS | 908 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 16:50:03 INFO - TEST-INFO | 908: exit 0 16:50:03 INFO - Browser initialized. 16:50:03 INFO - Running cycle 1/1 for kraken test... 16:50:03 INFO - TEST-INFO | started process 1027 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7A1xEe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:50:15 INFO - PROCESS | 1027 | RSS: Main: 168550400 16:50:15 INFO - PROCESS | 1027 | 16:50:18 INFO - PROCESS | 1027 | Cycle 1(1): loaded http://localhost:40171/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40171/tests/kraken/driver.html?testName=audio-beat-detection) 16:50:18 INFO - PROCESS | 1027 | RSS: Main: 174350336 16:50:18 INFO - PROCESS | 1027 | 16:50:21 INFO - PROCESS | 1027 | Cycle 1(1): loaded http://localhost:40171/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40171/tests/kraken/driver.html?testName=audio-dft) 16:50:22 INFO - PROCESS | 1027 | RSS: Main: 173477888 16:50:22 INFO - PROCESS | 1027 | 16:50:25 INFO - PROCESS | 1027 | Cycle 1(1): loaded http://localhost:40171/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40171/tests/kraken/driver.html?testName=audio-fft) 16:50:25 INFO - PROCESS | 1027 | RSS: Main: 167878656 16:50:25 INFO - PROCESS | 1027 | 16:50:27 INFO - PROCESS | 1027 | Cycle 1(1): loaded http://localhost:40171/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40171/tests/kraken/driver.html?testName=audio-oscillator) 16:50:28 INFO - PROCESS | 1027 | RSS: Main: 168411136 16:50:28 INFO - PROCESS | 1027 | 16:50:30 INFO - PROCESS | 1027 | Cycle 1(1): loaded http://localhost:40171/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40171/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:50:31 INFO - PROCESS | 1027 | RSS: Main: 169156608 16:50:31 INFO - PROCESS | 1027 | 16:50:34 INFO - PROCESS | 1027 | Cycle 1(1): loaded http://localhost:40171/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40171/tests/kraken/driver.html?testName=imaging-darkroom) 16:50:34 INFO - PROCESS | 1027 | RSS: Main: 168632320 16:50:34 INFO - PROCESS | 1027 | 16:50:38 INFO - PROCESS | 1027 | Cycle 1(1): loaded http://localhost:40171/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40171/tests/kraken/driver.html?testName=imaging-desaturate) 16:50:38 INFO - PROCESS | 1027 | RSS: Main: 170070016 16:50:38 INFO - PROCESS | 1027 | 16:50:41 INFO - PROCESS | 1027 | Cycle 1(1): loaded http://localhost:40171/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40171/tests/kraken/driver.html?testName=json-parse-financial) 16:50:42 INFO - PROCESS | 1027 | RSS: Main: 169459712 16:50:42 INFO - PROCESS | 1027 | 16:50:43 INFO - PROCESS | 1027 | Cycle 1(1): loaded http://localhost:40171/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40171/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:50:44 INFO - PROCESS | 1027 | RSS: Main: 169324544 16:50:44 INFO - PROCESS | 1027 | 16:50:46 INFO - PROCESS | 1027 | Cycle 1(1): loaded http://localhost:40171/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40171/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:50:47 INFO - PROCESS | 1027 | RSS: Main: 169279488 16:50:47 INFO - PROCESS | 1027 | 16:50:49 INFO - PROCESS | 1027 | Cycle 1(1): loaded http://localhost:40171/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40171/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:50:49 INFO - PROCESS | 1027 | RSS: Main: 169783296 16:50:49 INFO - PROCESS | 1027 | 16:50:52 INFO - PROCESS | 1027 | Cycle 1(1): loaded http://localhost:40171/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40171/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:50:53 INFO - PROCESS | 1027 | RSS: Main: 170131456 16:50:53 INFO - PROCESS | 1027 | 16:50:55 INFO - PROCESS | 1027 | Cycle 1(1): loaded http://localhost:40171/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40171/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:50:56 INFO - PROCESS | 1027 | RSS: Main: 170201088 16:50:56 INFO - PROCESS | 1027 | 16:50:57 INFO - PROCESS | 1027 | Cycle 1(1): loaded http://localhost:40171/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40171/tests/kraken/driver.html?testName=ai-astar) 16:50:58 INFO - PROCESS | 1027 | RSS: Main: 171171840 16:50:58 INFO - PROCESS | 1027 | 16:50:58 INFO - PROCESS | 1027 | __start_tp_report 16:50:58 INFO - PROCESS | 1027 | _x_x_mozilla_page_load 16:50:58 INFO - PROCESS | 1027 | _x_x_mozilla_page_load_details 16:50:58 INFO - PROCESS | 1027 | |i|pagename|runs| 16:50:58 INFO - PROCESS | 1027 | |0;ai-astar;105;111;108;112;112;114;115;112;112;113 16:50:58 INFO - PROCESS | 1027 | |1;audio-beat-detection;144;119;145;173;119;152;153;122;170;119 16:50:58 INFO - PROCESS | 1027 | |2;audio-dft;163;165;161;162;162;166;172;163;161;162 16:50:58 INFO - PROCESS | 1027 | |3;audio-fft;74;75;75;165;76;76;75;74;167;76 16:50:58 INFO - PROCESS | 1027 | |4;audio-oscillator;85;86;144;86;86;85;148;84;84;147 16:50:58 INFO - PROCESS | 1027 | |5;imaging-gaussian-blur;118;118;118;118;118;117;118;118;118;118 16:50:58 INFO - PROCESS | 1027 | |6;imaging-darkroom;148;148;146;146;146;147;148;148;146;147 16:50:58 INFO - PROCESS | 1027 | |7;imaging-desaturate;95;95;96;95;95;95;96;95;96;96 16:50:58 INFO - PROCESS | 1027 | |8;json-parse-financial;54;53;53;53;53;53;54;52;53;57 16:50:58 INFO - PROCESS | 1027 | |9;json-stringify-tinderbox;58;59;58;60;60;60;58;59;60;60 16:50:58 INFO - PROCESS | 1027 | |10;stanford-crypto-aes;76;75;84;78;75;77;75;74;80;75 16:50:58 INFO - PROCESS | 1027 | |11;stanford-crypto-ccm;142;124;120;129;140;133;120;142;164;139 16:50:58 INFO - PROCESS | 1027 | |12;stanford-crypto-pbkdf2;155;155;158;162;158;157;163;155;162;157 16:50:58 INFO - PROCESS | 1027 | |13;stanford-crypto-sha256-iterative;67;65;64;64;66;66;66;62;63;63 16:50:58 INFO - PROCESS | 1027 | __end_tp_report 16:50:58 INFO - PROCESS | 1027 | __start_cc_report 16:50:58 INFO - PROCESS | 1027 | _x_x_mozilla_cycle_collect,917 16:50:58 INFO - PROCESS | 1027 | __end_cc_report 16:50:58 INFO - PROCESS | 1027 | __startTimestamp1467330658233__endTimestamp 16:50:58 INFO - PROCESS | 1027 | 16:50:58 INFO - PROCESS | 1027 | ------- Summary: start ------- 16:50:58 INFO - PROCESS | 1027 | Number of tests: 14 16:50:58 INFO - PROCESS | 1027 | 16:50:58 INFO - PROCESS | 1027 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.00 stddev:2.91 (2.6%) stddev-sans-first:1.96 16:50:58 INFO - PROCESS | 1027 | Values: 105.0 111.0 108.0 112.0 112.0 114.0 115.0 112.0 112.0 113.0 16:50:58 INFO - PROCESS | 1027 | 16:50:58 INFO - PROCESS | 1027 | [#1] audio-beat-detection Cycles:10 Average:141.60 Median:148.50 stddev:20.99 (14.1%) stddev-sans-first:22.24 16:50:58 INFO - PROCESS | 1027 | Values: 144.0 119.0 145.0 173.0 119.0 152.0 153.0 122.0 170.0 119.0 16:50:58 INFO - PROCESS | 1027 | 16:50:58 INFO - PROCESS | 1027 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.00 stddev:3.33 (2.0%) stddev-sans-first:3.53 16:50:58 INFO - PROCESS | 1027 | Values: 163.0 165.0 161.0 162.0 162.0 166.0 172.0 163.0 161.0 162.0 16:50:58 INFO - PROCESS | 1027 | 16:50:58 INFO - PROCESS | 1027 | [#3] audio-fft Cycles:10 Average:93.30 Median:75.00 stddev:38.33 (51.1%) stddev-sans-first:40.01 16:50:58 INFO - PROCESS | 1027 | Values: 74.0 75.0 75.0 165.0 76.0 76.0 75.0 74.0 167.0 76.0 16:50:58 INFO - PROCESS | 1027 | 16:50:58 INFO - PROCESS | 1027 | [#4] audio-oscillator Cycles:10 Average:103.50 Median:85.00 stddev:29.58 (34.8%) stddev-sans-first:30.61 16:50:58 INFO - PROCESS | 1027 | Values: 85.0 86.0 144.0 86.0 86.0 85.0 148.0 84.0 84.0 147.0 16:50:58 INFO - PROCESS | 1027 | 16:50:58 INFO - PROCESS | 1027 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 16:50:58 INFO - PROCESS | 1027 | Values: 118.0 118.0 118.0 118.0 118.0 117.0 118.0 118.0 118.0 118.0 16:50:58 INFO - PROCESS | 1027 | 16:50:58 INFO - PROCESS | 1027 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.50 stddev:0.94 (0.6%) stddev-sans-first:0.93 16:50:58 INFO - PROCESS | 1027 | Values: 148.0 148.0 146.0 146.0 146.0 147.0 148.0 148.0 146.0 147.0 16:50:58 INFO - PROCESS | 1027 | 16:50:58 INFO - PROCESS | 1027 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 16:50:58 INFO - PROCESS | 1027 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 96.0 95.0 96.0 96.0 16:50:58 INFO - PROCESS | 1027 | 16:50:58 INFO - PROCESS | 1027 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:53.00 stddev:1.35 (2.6%) stddev-sans-first:1.42 16:50:58 INFO - PROCESS | 1027 | Values: 54.0 53.0 53.0 53.0 53.0 53.0 54.0 52.0 53.0 57.0 16:50:58 INFO - PROCESS | 1027 | 16:50:58 INFO - PROCESS | 1027 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:60.00 stddev:0.92 (1.5%) stddev-sans-first:0.87 16:50:58 INFO - PROCESS | 1027 | Values: 58.0 59.0 58.0 60.0 60.0 60.0 58.0 59.0 60.0 60.0 16:50:58 INFO - PROCESS | 1027 | 16:50:58 INFO - PROCESS | 1027 | [#10] stanford-crypto-aes Cycles:10 Average:76.90 Median:76.50 stddev:3.07 (4.0%) stddev-sans-first:3.24 16:50:58 INFO - PROCESS | 1027 | Values: 76.0 75.0 84.0 78.0 75.0 77.0 75.0 74.0 80.0 75.0 16:50:58 INFO - PROCESS | 1027 | 16:50:58 INFO - PROCESS | 1027 | [#11] stanford-crypto-ccm Cycles:10 Average:135.30 Median:139.50 stddev:13.29 (9.5%) stddev-sans-first:13.88 16:50:58 INFO - PROCESS | 1027 | Values: 142.0 124.0 120.0 129.0 140.0 133.0 120.0 142.0 164.0 139.0 16:50:58 INFO - PROCESS | 1027 | 16:50:58 INFO - PROCESS | 1027 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.20 Median:158.00 stddev:3.08 (2.0%) stddev-sans-first:3.05 16:50:58 INFO - PROCESS | 1027 | Values: 155.0 155.0 158.0 162.0 158.0 157.0 163.0 155.0 162.0 157.0 16:50:58 INFO - PROCESS | 1027 | 16:50:58 INFO - PROCESS | 1027 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:65.50 stddev:1.65 (2.5%) stddev-sans-first:1.50 16:50:58 INFO - PROCESS | 1027 | Values: 67.0 65.0 64.0 64.0 66.0 66.0 66.0 62.0 63.0 63.0 16:50:58 INFO - PROCESS | 1027 | -------- Summary: end -------- 16:50:58 INFO - PROCESS | 1027 | 16:50:59 INFO - TEST-INFO | 1027: exit 0 16:50:59 INFO - TEST-OK | kraken | took 62011ms 16:50:59 INFO - SUITE-END | took 1173s 16:50:59 INFO - Completed test suite (00:19:33) 16:50:59 INFO - javascript benchmark 16:50:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7405.771474460426, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3149.590553228081, 3162.557241986121, 3199.4081094997437, 3207.631122420922, 3217.5978002749644, 5381.0, 5518.503334699876, 5537.390887002426, 5542.1132618781, 5553.666779993203, 5456.727163641822, 5505.559555235582, 5509.228707980876, 5516.558675305976, 5590.664560126395, 4884.926726099103, 4912.7297998610065, 5021.347224860763, 5084.898302033957, 5118.769655365499, 815.2578765172434, 4915.213565829468, 4919.508049195069, 4924.2121260598315, 5049.64652474327, 4957.776900039471, 4959.107360675077, 4965.900681986358, 4974.77613507393, 4996.950030499721, 5011.599072074262, 5014.724190169539, 5026.0, 5039.924401133986, 5040.36995375578, 4860.611151107938, 4918.3360246367, 4962.454130045692, 4983.302337672729, 5010.674306170087, 5453.345598528163, 5570.080936645449, 5590.413006634326, 5591.217229587861, 5616.129499927518, 5721.5708821838525, 5870.853228669274, 5882.499987501024, 5905.645661260338, 5912.586118971673, 5936.910946335808, 5996.610220335664, 6022.608530445551, 6024.397560243984, 6065.909011364833, 5560.638558493725, 5562.499375056183, 5568.053430916754, 5570.86072848178, 5577.386487486373, 6024.548158888101, 6081.452669259788, 6081.5742897996715, 6095.542834287447, 6111.663858487737, 5789.0, 5836.299644042742, 5843.649381037151, 5860.033094539353, 5863.970680146572, 5923.466887980103, 6022.879542409128, 6031.065184896348, 6031.2159419276095, 6043.7280322385595, 5853.0635098384055, 5887.558433117533, 5968.7015649217365, 6019.578629495893, 6035.909461358083, 5941.079132734433, 5952.10718392236, 5953.732082056318, 5981.461668449861, 6037.698115094316, 4489.506154323022, 4491.775411229491, 4500.594946454769, 4504.3919070925, 4520.095980803852, 3889.0666240102173, 3943.408488726714, 3981.3231750602467, 3986.421968814506, 4003.199360127928, 5626.324841019104, 5643.266375371258, 5677.233573467612, 5689.146628005832, 5708.828735137952, 5998.1002849572915, 6003.189569408074, 6006.0, 6013.729382177812, 6016.939830601726, 5472.179173123984, 5552.472515111058, 5568.693721845257, 5588.497035266845, 5726.226959360516, 4918.754062296871, 4933.925991110136, 4949.876253093701, 4971.602271818246, 4975.776090075955, 6082.330943596201, 6085.66528840918, 6088.786892458743, 6099.634021958696, 6131.448169664752, 5821.534277257724, 5873.148393482836, 5886.646801191857, 5894.882102358015, 5952.285725712942, 6137.907931380943, 6188.504919606331, 6188.907166392598, 6210.0, 6222.0355844844125, 5932.673702946379, 5938.881222375442, 5944.940550594439, 5945.970270148621, 5960.374160713062, 5784.045632470596, 5925.733341999534, 5951.1073338999495, 5971.253593300838, 6007.098935159761, 5829.8251052468495, 5849.94150058494, 5861.589688721749, 5864.384239654945, 5878.970605146947, 5795.8551036224435, 5825.0679891217205, 5835.766569337179, 5835.912461313169, 5840.649561026352, 5538.833834984957, 5662.2639056922335, 5683.9715801420725, 5756.366799652119, 5806.2451881255165, 5811.418858114154, 5864.120381942743, 5909.970450147722, 5915.349311575637, 5920.526357891272, 5552.555795536428, 5780.248567686174, 5785.971070144622, 5792.652440853562, 5794.420557944172], "value": 5428.9489563270645, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.0615823919088, 607.3986753114417, 635.8378613453572, 638.6966191059246, 662.8077857421348, 38897.0, 43892.780536097314, 43920.34119488202, 44207.0, 44212.90509664325, 43393.56606433943, 43404.56595434045, 43491.782541087254, 43559.78220108903, 43929.12141757163, 8930.106989301083, 9070.183683468487, 9073.36486445949, 9078.727638170833, 9104.63581456741, 8873.29013678904, 9029.0519495453, 9030.819383612325, 9033.457992520436, 9041.864372034424, 9069.501177435239, 9085.091490850895, 9110.0, 9112.362134650577, 9134.17792398684, 8944.060873608276, 8948.552572371387, 9036.8644470333, 9047.638094476213, 9100.63597456101, 8786.60460279289, 8810.427322224099, 8828.382013259074, 8857.424267422597, 8860.158284962918, 42248.366274505905, 42661.57338426607, 42664.0, 42755.78622106901, 42774.0, 3555.5377800885717, 4129.793510324472, 4240.533541310484, 4249.745015299061, 4257.063446041866, 33695.32609347799, 33875.6612433875, 34160.14599635004, 34240.31519369624, 35239.82380088109, 4414.823407063714, 4575.771211439414, 4679.74261415622, 4688.789004494806, 4728.172569800271, 256345.0, 256542.0, 256889.0, 257068.7146564274, 258357.0, 36531.81734091313, 37463.0, 37481.25037499235, 60653.69673151606, 61047.38952610506, 39518.604813952064, 39566.406503902464, 39627.405588915615, 39803.40294895579, 39912.0, 14818.481353152803, 14957.775633365509, 14967.176805275814, 14971.251437428085, 15033.849661503464, 12175.756484870253, 12370.690732731573, 12405.379731013414, 12415.875841241472, 12427.130100892851, 9032.0, 9040.457572545669, 9066.184043436122, 9082.500462474627, 9148.2681385489, 3400.3199360128074, 3546.6453354664327, 3581.426971684518, 3598.5142005829402, 3602.927941441209, 1046.6807623674852, 1056.4823236614004, 1074.9140068794477, 1079.6653037558383, 1120.6862078618, 32977.175570610925, 33029.0, 33068.66931330656, 33349.333013339594, 33392.33215335728, 1104.7900898829196, 1120.7086157599083, 1126.7633796902742, 1173.9589114381126, 1187.554666999875, 17375.73936390955, 17562.912185438992, 17805.109744512723, 17830.46508604744, 17838.37565685195, 597321.0, 599347.0, 602820.0, 602883.0, 607913.0, 61153.0, 61517.0, 61666.69166654138, 61694.38305616976, 61709.382906170365, 1329.694170340827, 1360.2994457854213, 1377.1668140774887, 1383.75784237758, 1389.9722005560034, 31521.684783151875, 32389.19027024343, 32482.18794530061, 33009.174770629965, 33320.833395832866, 54273.45726542684, 54407.0, 54417.72791136019, 54713.452865470834, 54885.0, 440039.0, 442955.2817887248, 444077.0, 446736.0, 447808.0, 29571.85214074002, 30207.395852083275, 30581.23546911345, 30672.846635766677, 30760.692393075784, 43469.56530434655, 43683.781581093164, 44167.77916110399, 44209.33685994648, 44253.55746442494, 42820.35769463398, 43066.56933430751, 43290.78354608207, 43749.12501750011, 45008.32487512755, 42591.3611295837, 43172.84135793261, 43916.78041609772, 44047.11905761931, 44634.55365446304, 42335.7883210582, 43025.78487107545, 43430.34854477122, 43604.34593481037, 45429.77285113553, 35606.821965890005, 38655.226895462496, 38864.6113538861, 39066.60933390629, 39292.80353598328, 28565.42869142647, 28599.857000714863, 28808.135755927357, 28863.56704649474, 28937.855310723313], "value": 19300.28117990478, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.7734034950951, 421.9240536703396, 424.6581501890978, 428.4494424664306, 441.9071994881075, 19281.71077433838, 20052.99999999998, 20940.16239350426, 20969.161233550676, 21006.0, 19137.0, 19463.221471141173, 19905.502362440948, 20007.199712011537, 20502.384928452135, 5255.264263003173, 5447.291852059227, 5457.290552228224, 5462.617616766828, 5464.836054918359, 5403.83788486346, 5450.236966824647, 5480.698561579112, 5650.63270887391, 5947.078202878561, 5822.505087067604, 5886.117082437647, 5900.822975310747, 5942.078977758454, 5948.167256584082, 5899.380565040652, 5907.645541267516, 6487.383698548654, 6780.0, 6838.350356716104, 5990.801839632048, 6165.506759459233, 6180.258368995749, 6188.164597779332, 6216.285127210338, 24748.133815316378, 25103.246902592953, 25299.747002529923, 25368.619470707956, 25722.0, 2488.751124887515, 2595.1954893982925, 2678.892844286226, 2782.7634651054686, 2995.445842519141, 10809.459527023697, 10986.340819550853, 11020.669379918616, 13599.388027538685, 14251.216183109926, 1833.1292635997927, 1926.1043614719083, 1992.1031955205005, 1994.4614953962493, 2077.5849684696486, 87253.56373218157, 91617.54191229, 92530.53734731351, 93588.53205733928, 94619.0, 11902.404879755977, 11971.580994665319, 12363.701811309684, 12380.876191238152, 12697.174683645533, 16810.243539040774, 16968.49094527166, 16988.660226795393, 17025.829741702673, 17036.403725869535, 8063.637136328879, 8072.677092916218, 8177.345812334999, 8225.588720564068, 8380.16198380157, 7535.924640753522, 7539.208383119803, 7685.769426917202, 7745.225477452323, 7979.294804215014, 4908.312836202935, 5042.218456139304, 5077.18764997606, 5079.273047163982, 5124.000819840096, 2093.926712565053, 2132.5095228097316, 2148.9355319340443, 2155.8167555757936, 2168.7831216878503, 885.5572213893054, 966.3187452845727, 984.0503913723292, 989.5200827598609, 1024.3956065921143, 19244.422667320003, 20317.79682203159, 20322.288719894732, 20405.183792648426, 20435.59128817445, 1020.2756043209256, 1026.1739299863532, 1029.6653587584065, 1031.3914790273625, 1080.9675709728722, 10726.0, 11317.547298108148, 11450.255733377471, 11483.42582870853, 11525.423728813694, 427141.0, 430708.0, 448366.0, 451507.0, 452509.0, 56673.149902751495, 78712.0, 100277.49861250793, 102994.48502757438, 104916.47541762242, 995.4326034160459, 995.7809281957958, 1021.8313978193663, 1024.2215915903967, 1032.5818043692316, 17440.21519031672, 18231.817681823013, 18466.538336541693, 18761.812381876553, 18944.52638684044, 43511.56488435075, 48080.75959620319, 48493.51506485031, 48743.0, 50178.0, 61449.0, 62429.0, 62849.0, 63782.0, 64214.67892660507, 9034.322425817958, 9339.85990210161, 9403.106704863027, 9409.858852117086, 9602.039796020343, 11152.386618735723, 14226.35981380861, 14436.350364233846, 14673.559793206221, 14838.0, 12333.321667308384, 12600.369981500706, 12602.274147194801, 12753.171043882117, 12828.486860525474, 12405.0, 12489.250644961332, 12670.303133327756, 12807.359632018548, 12875.484980600671, 12222.633321000385, 12841.93579032099, 12913.0, 13065.412056457291, 13172.736545269232, 9048.728538143867, 9067.546622668708, 9086.54567271647, 9183.586738596645, 9203.815923681355, 9276.675316364164, 12294.323812190416, 12381.62855114348, 12385.19496232742, 12600.621981340575], "value": 9728.827478561918, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1485.95542133736, 1513.092144713172, 1671.899686018839, 1733.757273981642, 1800.4508624869418, 7780.533168009923, 8241.670333186665, 8442.91557084429, 8939.865902011476, 8973.057828927958, 8300.0, 8495.405321627473, 8544.23101920827, 8609.741707748763, 8614.396992210532, 2372.9881350593264, 2401.5317013182434, 2409.9518009639883, 2411.794997425221, 2414.541237164933, 2376.988115059431, 2379.6787433696404, 2416.359664688859, 2424.73327933928, 2435.4885474050384, 2406.097713357491, 2417.2627348658652, 2424.442378253003, 2431.732509423962, 2436.1473484280536, 2337.8947947342326, 2347.612643913752, 2359.693239878805, 2360.0441821062495, 2402.003168684994, 2320.2459200759654, 2346.0615753698485, 2352.5882970480097, 2362.421206804344, 2371.703537057868, 8479.576021198915, 8610.956945215234, 8651.264642505395, 8653.740387788377, 8667.869981950276, 5248.160294352885, 5409.540189083933, 5420.620556561003, 5439.619226654097, 5441.075017247077, 3441.397755392821, 3473.9131521711906, 3478.1826270826336, 3487.319972605343, 3490.790552566829, 1212.7513859658836, 1212.872648371917, 1213.5509861351268, 1219.2562536852513, 1232.2175418609158, 11648.417579121095, 11862.991645710124, 11897.94051029748, 11909.047276217969, 11929.224600401032, 4517.503074661785, 4653.581177694024, 4785.090832741837, 4786.904261914742, 4788.545088216614, 10035.448050357301, 10074.546645400975, 10112.393256404492, 10138.645147419953, 10157.898421015696, 5390.97304513475, 5391.622586418913, 5407.594430417735, 5424.918626220609, 5431.646942948775, 4352.891177720519, 4797.376341075638, 4945.0, 4946.282788995575, 5004.9499505005215, 3957.3470377387407, 4045.6561192298395, 4096.959030409717, 4134.607212314825, 4136.44158038667, 1313.1923866822026, 1338.5649663859285, 1340.2159736554224, 1351.304078399625, 1359.4901911783081, 1002.4236064263077, 1002.6991902429243, 1020.260311274335, 1021.4126877045728, 1029.5469993202967, 5942.197803296586, 5991.850203744854, 6095.2685677718955, 6132.938670613326, 6265.655388953652, 476.56156336170113, 478.89943111946883, 490.83557008402585, 493.84937594034164, 499.56537812102977, 4225.9577404226175, 4271.957280427218, 4310.4611923509565, 4329.0, 4349.086691794695, 10627.256092073481, 11058.944705276583, 11083.944580277048, 11124.777504449865, 11160.441977901073, 9647.903520964841, 10091.596336146471, 11060.336379817236, 11088.168387370979, 11089.72275693098, 8295.875561866576, 8396.958015209884, 8458.534780587126, 8509.702160424355, 8520.74437766868, 5830.708464576839, 5922.674252915958, 6041.395860413923, 6042.244719410074, 6137.570370074052, 9415.952920235355, 9932.0, 10070.14403775658, 10209.132223761064, 10214.438205898747, 9907.702768916944, 10048.0, 10081.647142349982, 10122.797544049225, 10229.43738094412, 6910.0, 7370.447216458894, 7596.088469383489, 7596.544207347577, 7739.1100023495765, 8297.377696672653, 8410.074891762024, 8429.325653947792, 8526.0, 8530.402871798915, 7525.736599219001, 7687.884681729666, 7716.652750626123, 7834.373250139861, 7855.7250496232355, 7521.811954701177, 7608.581528016012, 7648.80877978055, 7750.767476975474, 7772.417068719756, 6744.494162937701, 6751.831204219934, 6758.222804377363, 6778.2205046420295, 6797.6941037654415, 5103.8468845934685, 5237.947620523899, 5262.368515777978, 5369.838904832861, 5470.0, 5225.0, 5240.397354304304, 5309.681419114865, 5421.376541697755, 5453.890922181455], "value": 4611.49898861941, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.45867071356554, 350.3133857639027, 350.93683137035333, 360.89534035129816, 361.35317781171705, 5525.0, 5602.943970560294, 5656.745446454915, 5739.483446489815, 5745.195672605833, 5570.526505247059, 5638.126090455976, 5641.802536911209, 5649.378568357477, 5649.46330098641, 4414.29371300592, 4417.249067658498, 4431.711938723989, 4431.844885429011, 4451.731256591872, 4169.811603692948, 4395.494518130408, 4417.4919884213405, 4446.555344465543, 4452.287633978564, 4328.761918094504, 4344.826206951718, 4345.630621397185, 4370.125974805036, 4388.363687265361, 4335.9566404335865, 4337.891552711176, 4362.0, 4374.19077470669, 4413.881336958278, 3799.4680744695765, 3857.1707082977296, 3875.4574359589396, 3877.3214687429586, 3877.7702820877826, 5473.728402712869, 5475.589330800206, 5514.207882438223, 5528.944710552923, 5577.888442231173, 5047.570956468705, 5076.593872490192, 5079.171498260624, 5080.364954380702, 5096.439391666913, 5792.061398249231, 5965.612235204698, 5987.9101813472835, 5999.220101386792, 6038.365971573009, 4172.144710334374, 4175.54069052404, 4185.790710464495, 4202.642775364097, 4227.387028880826, 6245.189664650925, 6270.435660790505, 6281.581591087419, 6284.4344009039405, 6289.465395441393, 4192.496900371975, 4339.153864996296, 4345.391645169679, 4396.340548917624, 4426.26966550522, 4409.2724700424715, 4439.755813430293, 4439.889002774892, 4442.42248507692, 4467.486239082482, 5082.923756143661, 5083.288339632454, 5089.923651145235, 5092.28707980883, 5094.719790411563, 5781.942180578225, 5856.690969602161, 6045.911735887495, 6054.848628784228, 6062.939370606326, 1507.216247551267, 1526.137732181314, 1530.6326481644326, 1533.9693206135814, 1535.4702627593463, 941.6939494664261, 943.6649989253854, 945.7351941456403, 954.6229239450518, 980.926430517714, 4913.852584422473, 5027.245913113063, 5058.291839142523, 5107.0, 5135.276924229904, 5390.595705322116, 5410.430975017201, 5419.561197461158, 5427.891442171134, 5443.618946673774, 4962.627802914796, 4989.575886049726, 5003.399592048904, 5024.221245706848, 5156.690598564098, 2853.6432945881766, 2870.512012957802, 2886.5525843494293, 2896.3772788850497, 2899.855007249629, 5480.451590010664, 5573.275474188411, 5583.581231407661, 5585.860353491195, 5620.690862002547, 5601.159826026129, 5891.587588868738, 6269.968650156811, 6307.274663413675, 6310.747570097236, 6268.623882567061, 6306.779262725782, 6348.333424990402, 6370.968145159337, 6384.106225128486, 6054.243219597551, 6139.772045590989, 6147.72335244924, 6177.660228687465, 6184.319724830355, 6117.816465506042, 6137.539684523589, 6155.861165684362, 6178.227721534809, 6178.691065446799, 6203.844903877439, 6356.96577095325, 6412.0, 6436.517261205335, 6469.350315669474, 4434.667399945081, 4459.754713490789, 4470.955290447054, 4478.0, 4494.752788596527, 5811.912821307768, 5966.552508561788, 6149.877002460015, 6166.630002199882, 6174.135621013152, 5970.283565972111, 6029.457348838626, 6069.362716914837, 6071.878562428638, 6090.573659843769, 5989.820305390671, 6000.399960003964, 6007.519398448027, 6011.458968692838, 6079.483243924316, 5561.416051314553, 5833.270841144857, 5853.268341457318, 5866.560007999503, 5889.293284805851, 5949.196858424058, 6022.668753218615, 6042.97269464201, 6043.8186854394435, 6068.271807383142, 5651.2935883014625, 5855.736491857791, 5861.1537365729655, 5866.0, 5884.588078834612], "value": 4463.658467244112, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [671.1509939925992, 675.4225137507434, 728.2608152724983, 743.7619961612282, 770.2913319745833, 15011.0, 16077.919610401961, 16096.0, 16109.677806443864, 16197.83802161978, 14587.12477251363, 14764.040337378063, 14770.0, 15105.62235944102, 15197.77203341948, 676.2020815437781, 802.6307898366758, 817.7342363731796, 835.6281454752638, 837.476577139288, 820.6471217376526, 827.0, 828.0973738624898, 828.5028982610446, 830.248624994378, 890.5235698901089, 891.0554811899408, 892.1078921078921, 892.2148509311829, 892.464521287229, 872.8385248729005, 874.2525141004445, 877.368294827723, 877.7366789963049, 878.7846977490492, 638.5147288061061, 639.1690801957483, 639.9648019358933, 640.7565125252421, 641.3778634724357, 15805.762913556306, 15978.920105399515, 15985.44050958211, 15999.0, 16004.199790010452, 15594.376224951102, 15651.452199172974, 15653.765193522106, 15761.290741916526, 15891.205439728083, 12889.806652900214, 12901.67745806353, 12920.806187907188, 13031.739365212738, 13167.872461114339, 3963.4649322341693, 4016.3975403689387, 4072.6538244249273, 4126.257273690734, 4210.810513526868, 87831.12168878358, 87878.5606071972, 88585.0, 89127.55436222778, 91598.5420072902, 12019.158658893968, 12061.638150855488, 12231.755364892651, 12307.93846030782, 12393.62819115428, 20539.281125160847, 20617.79382206189, 20625.690614640793, 20680.896595516926, 20689.79310206909, 8545.74362769118, 8653.78846961426, 8663.870041949376, 8827.249683776823, 8974.68588599409, 4851.223804191312, 4898.902021959612, 4912.312276281252, 4933.753312334441, 5011.5489605935645, 3434.7767395119236, 3527.700145487611, 3545.7517973742106, 3593.94609080864, 3625.655562721537, 594.9940500595026, 595.3510673365965, 628.8836565235355, 631.1857703562445, 650.6226388694546, 759.3811043999123, 760.5778792770066, 769.61134627013, 769.7036640893297, 785.0775338976794, 10033.046860548237, 10101.545430455648, 10376.533056012497, 10496.527656255486, 10518.0, 598.60791181776, 648.6918713611092, 671.8725225939463, 687.2062767503542, 764.0258670195434, 4580.954190458119, 5104.744762761847, 5290.285811415487, 5313.787448502017, 5450.0, 77573.0, 123676.0, 123836.0, 124288.0, 125996.37001814932, 109623.0, 110149.0, 111727.0, 112447.0, 112966.43516782527, 87678.0, 90879.54560227157, 93930.5303473492, 95097.0, 95408.0, 9566.760830979281, 9827.901720982985, 9839.68105861394, 10058.145057669888, 10149.122412353738, 43644.0, 44698.77650611726, 47348.52651473441, 53220.2016969738, 56597.43402565922, 74995.0, 76700.61649691715, 77316.61341693255, 77820.61089694516, 82479.0, 12999.672101827242, 13158.473661053451, 13384.93307533456, 13618.455261789417, 14083.859161408254, 14588.854111459174, 15406.0, 15666.0, 15986.360545578513, 16062.357505699641, 14202.0, 14469.27653617336, 14523.128612283297, 14555.345009474388, 14760.409583616534, 14086.647833804236, 14214.857851421353, 14463.638409039859, 14480.493182738554, 14693.33879975425, 14199.416816775158, 14205.857941420454, 14915.701685966436, 14945.701085978437, 15353.309101090254, 11741.76516469683, 11982.460789264678, 12046.216995895238, 12138.393080346124, 12259.632211033684, 10923.508442119964, 10969.670909872717, 11376.0, 11611.47748351343, 12490.500379985062], "value": 7861.526482454728, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1521.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 111.0, 108.0, 112.0, 112.0, 114.0, 115.0, 112.0, 112.0, 113.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 119.0, 145.0, 173.0, 119.0, 152.0, 153.0, 122.0, 170.0, 119.0], "value": 141.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 161.0, 162.0, 162.0, 166.0, 172.0, 163.0, 161.0, 162.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 165.0, 76.0, 76.0, 75.0, 74.0, 167.0, 76.0], "value": 93.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 144.0, 86.0, 86.0, 85.0, 148.0, 84.0, 84.0, 147.0], "value": 103.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 146.0, 146.0, 146.0, 147.0, 148.0, 148.0, 146.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 53.0, 53.0, 53.0, 54.0, 52.0, 53.0, 57.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 60.0, 60.0, 60.0, 58.0, 59.0, 60.0, 60.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 84.0, 78.0, 75.0, 77.0, 75.0, 74.0, 80.0, 75.0], "value": 76.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 124.0, 120.0, 129.0, 140.0, 133.0, 120.0, 142.0, 164.0, 139.0], "value": 135.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 155.0, 158.0, 162.0, 158.0, 157.0, 163.0, 155.0, 162.0, 157.0], "value": 158.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 64.0, 64.0, 66.0, 66.0, 66.0, 62.0, 63.0, 63.0], "value": 64.6, "unit": "score"}]}]} 16:50:59 INFO - Return code: 0 16:50:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:50:59 ERROR - # TBPL SUCCESS # 16:50:59 INFO - Running post-action listener: _resource_record_post_action 16:50:59 INFO - ##### 16:50:59 INFO - ##### Finished run-tests step (success) 16:50:59 INFO - ##### 16:50:59 INFO - Running post-run listener: _resource_record_post_run 16:50:59 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 550899712; Read time: 12; Write time: 599836 16:50:59 INFO - TinderboxPrint: CPU usage
13.3% 16:50:59 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 16:50:59 INFO - TinderboxPrint: I/O write bytes / time
550,899,712 / 599,836 16:50:59 INFO - TinderboxPrint: CPU idle
8,234.3 (86.6%) 16:50:59 INFO - TinderboxPrint: CPU user
1,212.9 (12.8%) 16:50:59 INFO - TinderboxPrint: Swap in / out
0 / 0 16:50:59 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 255873024; Read time: 0; Write time: 299876 16:50:59 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 294273024; Read time: 0; Write time: 299952 16:51:00 INFO - Running post-run listener: _upload_blobber_files 16:51:00 INFO - Blob upload gear active. 16:51:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:51:00 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 16:51:00 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:51:00 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:51:00 INFO - (blobuploader) - INFO - Open directory for files ... 16:51:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:51:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:51:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:51:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:51:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:51:04 INFO - (blobuploader) - INFO - Done attempting. 16:51:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:51:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:51:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:51:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:51:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:51:04 INFO - (blobuploader) - INFO - Done attempting. 16:51:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:51:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:51:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:51:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:51:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:51:05 INFO - (blobuploader) - INFO - Done attempting. 16:51:05 INFO - (blobuploader) - INFO - Iteration through files over. 16:51:05 INFO - Return code: 0 16:51:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:51:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:51:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8e5cd215c7f4704e0bfc240fcf92a41674e0b5ca458e941f22f35bc53b60aaec11ee29e9fb0bc4be0c4b07c055ba41e8059ffe12fc2ab5859b0cf1a6757a4f5a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/79996654cc1c6ef8e5178460a4573a01f1bafc25c7a5b685b524e47309f30e83125f449d9eb0fcf1de63e3f950898f98c94d42790e15ab70b2f093fd1b4a8368", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5ac6ec869f2f3a2e8a7f020d61cef61526490ec685dff3c7435169c8983e1ab23b44d73da406f8928bb583a77d7c773e19ac21cbf6744d7bee3aaa39ebda3942"} 16:51:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:51:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:51:05 INFO - Contents: 16:51:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8e5cd215c7f4704e0bfc240fcf92a41674e0b5ca458e941f22f35bc53b60aaec11ee29e9fb0bc4be0c4b07c055ba41e8059ffe12fc2ab5859b0cf1a6757a4f5a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/79996654cc1c6ef8e5178460a4573a01f1bafc25c7a5b685b524e47309f30e83125f449d9eb0fcf1de63e3f950898f98c94d42790e15ab70b2f093fd1b4a8368", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5ac6ec869f2f3a2e8a7f020d61cef61526490ec685dff3c7435169c8983e1ab23b44d73da406f8928bb583a77d7c773e19ac21cbf6744d7bee3aaa39ebda3942"} 16:51:05 INFO - Running post-run listener: copy_logs_to_upload_dir 16:51:05 INFO - Copying logs to upload dir... 16:51:05 INFO - mkdir: /builds/slave/test/build/upload/logs 16:51:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.539355 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-06-30 16:51:05.365065) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 16:51:05.368753) ========= 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=eca2ab57546de7b41f256b19000001ef-1467329299.750888-955130584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8e5cd215c7f4704e0bfc240fcf92a41674e0b5ca458e941f22f35bc53b60aaec11ee29e9fb0bc4be0c4b07c055ba41e8059ffe12fc2ab5859b0cf1a6757a4f5a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/79996654cc1c6ef8e5178460a4573a01f1bafc25c7a5b685b524e47309f30e83125f449d9eb0fcf1de63e3f950898f98c94d42790e15ab70b2f093fd1b4a8368", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5ac6ec869f2f3a2e8a7f020d61cef61526490ec685dff3c7435169c8983e1ab23b44d73da406f8928bb583a77d7c773e19ac21cbf6744d7bee3aaa39ebda3942"} build_url:https://queue.taskcluster.net/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011357 build_url: 'https://queue.taskcluster.net/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8e5cd215c7f4704e0bfc240fcf92a41674e0b5ca458e941f22f35bc53b60aaec11ee29e9fb0bc4be0c4b07c055ba41e8059ffe12fc2ab5859b0cf1a6757a4f5a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/79996654cc1c6ef8e5178460a4573a01f1bafc25c7a5b685b524e47309f30e83125f449d9eb0fcf1de63e3f950898f98c94d42790e15ab70b2f093fd1b4a8368", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5ac6ec869f2f3a2e8a7f020d61cef61526490ec685dff3c7435169c8983e1ab23b44d73da406f8928bb583a77d7c773e19ac21cbf6744d7bee3aaa39ebda3942"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 16:51:05.394910) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 16:51:05.395276) ========= 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=eca2ab57546de7b41f256b19000001ef-1467329299.750888-955130584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004547 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 16:51:05.477641) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 16:51:05.478036) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 16:51:05.478367) ========= ========= Total master_lag: 0.17 =========