builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-056 starttime: 1467988714.1 results: success (0) buildid: 20160708070926 builduid: fb65d64d240a458e8b2fc23515c94363 revision: a2df0e1a03d970d20d89ad57c5748ab5d26f2e1e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 07:38:34.104207) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 07:38:34.105344) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 07:38:34.106062) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 07:38:34.125990) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 07:38:34.126648) ========= 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=52faae308a556c440401f8e5000001e8-1467988714.434558-1910852929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-08 07:38:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 12.8M=0.001s 2016-07-08 07:38:35 (12.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.112382 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 07:38:34.254724) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 07:38:34.255088) ========= 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=52faae308a556c440401f8e5000001e8-1467988714.434558-1910852929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021455 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 07:38:34.308083) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 07:38:34.308868) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a2df0e1a03d970d20d89ad57c5748ab5d26f2e1e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev a2df0e1a03d970d20d89ad57c5748ab5d26f2e1e --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=52faae308a556c440401f8e5000001e8-1467988714.434558-1910852929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-08 07:38:35,808 truncating revision to first 12 chars 2016-07-08 07:38:35,808 Setting DEBUG logging. 2016-07-08 07:38:35,808 attempt 1/10 2016-07-08 07:38:35,808 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a2df0e1a03d9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-08 07:38:36,117 unpacking tar archive at: fx-team-a2df0e1a03d9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.611045 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 07:38:34.938317) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 07:38:34.938800) ========= script_repo_revision: a2df0e1a03d970d20d89ad57c5748ab5d26f2e1e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 07:38:34.939268) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 07:38:34.939585) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 07:38:34.951014) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-07-08 07:38:34.951642) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1467988714.434558-1910852929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:38:36 INFO - MultiFileLogger online at 20160708 07:38:36 in /builds/slave/test 07:38:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 07:38:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:38:36 INFO - {'append_to_log': False, 07:38:36 INFO - 'base_work_dir': '/builds/slave/test', 07:38:36 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:38:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:38:36 INFO - 'branch': 'Fx-Team-Non-PGO', 07:38:36 INFO - 'buildbot_json_path': 'buildprops.json', 07:38:36 INFO - 'config_files': ('talos/linux_config.py',), 07:38:36 INFO - 'default_actions': ('clobber', 07:38:36 INFO - 'read-buildbot-config', 07:38:36 INFO - 'download-and-extract', 07:38:36 INFO - 'populate-webroot', 07:38:36 INFO - 'create-virtualenv', 07:38:36 INFO - 'install', 07:38:36 INFO - 'run-tests'), 07:38:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:38:36 INFO - 'download_minidump_stackwalk': True, 07:38:36 INFO - 'download_symbols': 'ondemand', 07:38:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:38:36 INFO - 'tooltool.py': '/tools/tooltool.py', 07:38:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:38:36 INFO - '/tools/misc-python/virtualenv.py')}, 07:38:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:38:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:38:36 INFO - 'installer_path': 'installer.exe', 07:38:36 INFO - 'log_level': 'info', 07:38:36 INFO - 'log_name': 'talos', 07:38:36 INFO - 'log_to_console': True, 07:38:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:38:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:38:36 INFO - 'opt_config_files': (), 07:38:36 INFO - 'pip_index': False, 07:38:36 INFO - 'sps_profile': False, 07:38:36 INFO - 'sps_profile_interval': 0, 07:38:36 INFO - 'suite': 'dromaeojs', 07:38:36 INFO - 'system_bits': '32', 07:38:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:38:36 INFO - 'title': 'talos-linux64-ix-056', 07:38:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:38:36 INFO - 'use_talos_json': True, 07:38:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:38:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:38:36 INFO - 'work_dir': 'build'} 07:38:36 INFO - ##### 07:38:36 INFO - ##### Running clobber step. 07:38:36 INFO - ##### 07:38:36 INFO - Running pre-action listener: _resource_record_pre_action 07:38:36 INFO - Running main action method: clobber 07:38:36 INFO - rmtree: /builds/slave/test/build 07:38:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:38:37 INFO - Running post-action listener: _resource_record_post_action 07:38:37 INFO - ##### 07:38:37 INFO - ##### Finished clobber step (success) 07:38:37 INFO - ##### 07:38:37 INFO - ##### 07:38:37 INFO - ##### Running read-buildbot-config step. 07:38:37 INFO - ##### 07:38:37 INFO - Running pre-action listener: _resource_record_pre_action 07:38:37 INFO - Running main action method: read_buildbot_config 07:38:37 INFO - Using buildbot properties: 07:38:37 INFO - { 07:38:37 INFO - "project": "", 07:38:37 INFO - "product": "firefox", 07:38:37 INFO - "script_repo_revision": "production", 07:38:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 07:38:37 INFO - "repository": "", 07:38:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 07:38:37 INFO - "buildid": "20160708070926", 07:38:37 INFO - "pgo_build": "False", 07:38:37 INFO - "basedir": "/builds/slave/test", 07:38:37 INFO - "buildnumber": 1954, 07:38:37 INFO - "slavename": "talos-linux64-ix-056", 07:38:37 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:38:37 INFO - "platform": "ubuntu64_hw", 07:38:37 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:38:37 INFO - "branch": "fx-team", 07:38:37 INFO - "repo_path": "integration/fx-team", 07:38:37 INFO - "revision": "a2df0e1a03d970d20d89ad57c5748ab5d26f2e1e", 07:38:37 INFO - "stage_platform": "linux64", 07:38:37 INFO - "builduid": "fb65d64d240a458e8b2fc23515c94363", 07:38:37 INFO - "slavebuilddir": "test" 07:38:37 INFO - } 07:38:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/VrFiOJmLRLegbNzi_YLCtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:38:37 INFO - Running post-action listener: _resource_record_post_action 07:38:37 INFO - ##### 07:38:37 INFO - ##### Finished read-buildbot-config step (success) 07:38:37 INFO - ##### 07:38:37 INFO - ##### 07:38:37 INFO - ##### Running download-and-extract step. 07:38:37 INFO - ##### 07:38:37 INFO - Running pre-action listener: _resource_record_pre_action 07:38:37 INFO - Running main action method: download_and_extract 07:38:37 INFO - mkdir: /builds/slave/test/build/tests 07:38:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:37 INFO - https://queue.taskcluster.net/v1/task/VrFiOJmLRLegbNzi_YLCtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:38:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrFiOJmLRLegbNzi_YLCtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:38:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrFiOJmLRLegbNzi_YLCtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:38:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrFiOJmLRLegbNzi_YLCtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:38:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrFiOJmLRLegbNzi_YLCtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:38:37 INFO - Downloaded 1361 bytes. 07:38:37 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:38:37 INFO - Using the following test package requirements: 07:38:37 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:38:37 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:38:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:38:37 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:38:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:38:37 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:38:37 INFO - u'jsshell-linux-x86_64.zip'], 07:38:37 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:38:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:38:37 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:38:37 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:38:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:38:37 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:38:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:38:37 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:38:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:38:37 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:38:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:38:37 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:38:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:37 INFO - https://queue.taskcluster.net/v1/task/VrFiOJmLRLegbNzi_YLCtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:38:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrFiOJmLRLegbNzi_YLCtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:38:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrFiOJmLRLegbNzi_YLCtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:38:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrFiOJmLRLegbNzi_YLCtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:38:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrFiOJmLRLegbNzi_YLCtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:38:38 INFO - Downloaded 22735131 bytes. 07:38:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:38:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:38:40 INFO - Return code: 0 07:38:40 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:38:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:40 INFO - https://queue.taskcluster.net/v1/task/VrFiOJmLRLegbNzi_YLCtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:38:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrFiOJmLRLegbNzi_YLCtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:38:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrFiOJmLRLegbNzi_YLCtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:38:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrFiOJmLRLegbNzi_YLCtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:38:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrFiOJmLRLegbNzi_YLCtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:38:41 INFO - Downloaded 22735131 bytes. 07:38:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:38:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:38:42 INFO - Return code: 0 07:38: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')]} 07:38:42 INFO - https://queue.taskcluster.net/v1/task/VrFiOJmLRLegbNzi_YLCtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:38:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrFiOJmLRLegbNzi_YLCtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:38:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrFiOJmLRLegbNzi_YLCtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:38:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrFiOJmLRLegbNzi_YLCtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:38:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrFiOJmLRLegbNzi_YLCtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:38:44 INFO - Downloaded 14403333 bytes. 07:38:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:38:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:38:44 INFO - Return code: 0 07:38:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:44 INFO - https://queue.taskcluster.net/v1/task/VrFiOJmLRLegbNzi_YLCtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:38:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrFiOJmLRLegbNzi_YLCtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:38:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrFiOJmLRLegbNzi_YLCtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:38:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrFiOJmLRLegbNzi_YLCtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:38:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrFiOJmLRLegbNzi_YLCtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:38:48 INFO - Downloaded 56651380 bytes. 07:38:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VrFiOJmLRLegbNzi_YLCtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:38:48 INFO - mkdir: /builds/slave/test/properties 07:38:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:38:48 INFO - Writing to file /builds/slave/test/properties/build_url 07:38:48 INFO - Contents: 07:38:48 INFO - build_url:https://queue.taskcluster.net/v1/task/VrFiOJmLRLegbNzi_YLCtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:38:49 INFO - Running post-action listener: _resource_record_post_action 07:38:49 INFO - Running post-action listener: set_extra_try_arguments 07:38:49 INFO - ##### 07:38:49 INFO - ##### Finished download-and-extract step (success) 07:38:49 INFO - ##### 07:38:49 INFO - ##### 07:38:49 INFO - ##### Running populate-webroot step. 07:38:49 INFO - ##### 07:38:49 INFO - Running pre-action listener: _resource_record_pre_action 07:38:49 INFO - Running main action method: populate_webroot 07:38:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:38:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:38:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:38:49 INFO - '--tppagecycles', 07:38:49 INFO - '7'], 07:38:49 INFO - 'tests': ['tsvgm']}}, 07:38:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:38:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:38:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:38:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:38:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:38:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:38:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:49 INFO - 'talos_options': ['--disable-e10s'], 07:38:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:38:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:38:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:49 INFO - 'talos_options': ['--disable-e10s'], 07:38:49 INFO - 'tests': ['damp', 'tps']}, 07:38:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:49 INFO - 'tests': ['damp', 'tps']}, 07:38:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:38:49 INFO - 'tests': ['dromaeo_dom']}, 07:38:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:38:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:38:49 INFO - 'tests': ['basic_compositor_video']}, 07:38:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:38:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:38:49 INFO - 'tests': ['a11yr', 07:38:49 INFO - 'ts_paint', 07:38:49 INFO - 'tpaint', 07:38:49 INFO - 'sessionrestore', 07:38:49 INFO - 'sessionrestore_no_auto_restore', 07:38:49 INFO - 'tabpaint']}, 07:38:49 INFO - 'other-e10s': {'tests': ['a11yr', 07:38:49 INFO - 'ts_paint', 07:38:49 INFO - 'tpaint', 07:38:49 INFO - 'sessionrestore', 07:38:49 INFO - 'sessionrestore_no_auto_restore', 07:38:49 INFO - 'tabpaint']}, 07:38:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:38:49 INFO - 'ts_paint', 07:38:49 INFO - 'tpaint', 07:38:49 INFO - 'sessionrestore', 07:38:49 INFO - 'sessionrestore_no_auto_restore', 07:38:49 INFO - 'tabpaint']}, 07:38:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:38:49 INFO - 'ts_paint', 07:38:49 INFO - 'tpaint', 07:38:49 INFO - 'sessionrestore', 07:38:49 INFO - 'sessionrestore_no_auto_restore', 07:38:49 INFO - 'tabpaint']}, 07:38:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:38:49 INFO - 'tests': ['a11yr', 07:38:49 INFO - 'ts_paint', 07:38:49 INFO - 'tpaint', 07:38:49 INFO - 'sessionrestore', 07:38:49 INFO - 'sessionrestore_no_auto_restore', 07:38:49 INFO - 'tabpaint']}, 07:38:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:38:49 INFO - 'tests': ['a11yr', 07:38:49 INFO - 'ts_paint', 07:38:49 INFO - 'tpaint', 07:38:49 INFO - 'sessionrestore', 07:38:49 INFO - 'sessionrestore_no_auto_restore', 07:38:49 INFO - 'tabpaint']}, 07:38:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:38:49 INFO - 'tests': ['tsvgx', 07:38:49 INFO - 'tsvgr_opacity', 07:38:49 INFO - 'tart', 07:38:49 INFO - 'tscrollx', 07:38:49 INFO - 'cart']}, 07:38:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:38:49 INFO - 'tsvgr_opacity', 07:38:49 INFO - 'tart', 07:38:49 INFO - 'tscrollx', 07:38:49 INFO - 'cart']}, 07:38:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:49 INFO - 'talos_options': ['--disable-e10s'], 07:38:49 INFO - 'tests': ['tp5o']}, 07:38:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:49 INFO - 'tests': ['tp5o']}, 07:38:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:49 INFO - 'talos_options': ['--disable-e10s', 07:38:49 INFO - '--xperf_path', 07:38:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:38:49 INFO - 'tests': ['tp5n']}, 07:38:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:49 INFO - 'talos_options': ['--xperf_path', 07:38:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:38:49 INFO - 'tests': ['tp5n']}}, 07:38:49 INFO - 'talos.zip': {'path': '', 07:38:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:38:49 INFO - Running post-action listener: _resource_record_post_action 07:38:49 INFO - ##### 07:38:49 INFO - ##### Finished populate-webroot step (success) 07:38:49 INFO - ##### 07:38:49 INFO - ##### 07:38:49 INFO - ##### Running create-virtualenv step. 07:38:49 INFO - ##### 07:38:49 INFO - Running pre-action listener: _resource_record_pre_action 07:38:49 INFO - Running main action method: create_virtualenv 07:38:49 INFO - Creating virtualenv /builds/slave/test/build/venv 07:38:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:38:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:38:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:38:49 INFO - Using real prefix '/usr' 07:38:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:38:49 INFO - Installing distribute.............................................................................................................................................................................................done. 07:38:51 INFO - Installing pip.................done. 07:38:51 INFO - Return code: 0 07:38:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:38: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')]} 07:38:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38: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')]} 07:38:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb0f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdce3b0>, '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 0xdcf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcf740>, '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': '52faae308a556c440401f8e5000001e8-1467988714.434558-1910852929', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:38: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', 'pip>=1.5'] in /builds/slave/test/build 07:38: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 pip>=1.5 07:38:51 INFO - Using env: {'DISPLAY': ':0', 07:38:51 INFO - 'HOME': '/home/cltbld', 07:38:51 INFO - 'LANG': 'en_US.UTF-8', 07:38:51 INFO - 'LANGUAGE': 'en_US:en', 07:38:51 INFO - 'LOGNAME': 'cltbld', 07:38:51 INFO - 'MAIL': '/var/mail/cltbld', 07:38:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:51 INFO - 'MOZ_NO_REMOTE': '1', 07:38:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:51 INFO - 'NO_EM_RESTART': '1', 07:38:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:51 INFO - 'PWD': '/builds/slave/test', 07:38:51 INFO - 'SHELL': '/bin/bash', 07:38:51 INFO - 'SHLVL': '1', 07:38:51 INFO - 'TERM': 'linux', 07:38:51 INFO - 'TMOUT': '86400', 07:38:51 INFO - 'USER': 'cltbld', 07:38:51 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467988714.434558-1910852929', 07:38:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:51 INFO - '_': '/tools/buildbot/bin/python'} 07:38:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:52 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:38:52 INFO - Cleaning up... 07:38:52 INFO - Return code: 0 07:38:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:38:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xb0f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdce3b0>, '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 0xdcf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcf740>, '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': '52faae308a556c440401f8e5000001e8-1467988714.434558-1910852929', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:38:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:38:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:38:52 INFO - Using env: {'DISPLAY': ':0', 07:38:52 INFO - 'HOME': '/home/cltbld', 07:38:52 INFO - 'LANG': 'en_US.UTF-8', 07:38:52 INFO - 'LANGUAGE': 'en_US:en', 07:38:52 INFO - 'LOGNAME': 'cltbld', 07:38:52 INFO - 'MAIL': '/var/mail/cltbld', 07:38:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:52 INFO - 'MOZ_NO_REMOTE': '1', 07:38:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:52 INFO - 'NO_EM_RESTART': '1', 07:38:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:52 INFO - 'PWD': '/builds/slave/test', 07:38:52 INFO - 'SHELL': '/bin/bash', 07:38:52 INFO - 'SHLVL': '1', 07:38:52 INFO - 'TERM': 'linux', 07:38:52 INFO - 'TMOUT': '86400', 07:38:52 INFO - 'USER': 'cltbld', 07:38:52 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467988714.434558-1910852929', 07:38:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:52 INFO - '_': '/tools/buildbot/bin/python'} 07:38:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:52 INFO - Downloading/unpacking psutil>=3.1.1 07:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:38:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:38:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:38:54 INFO - Installing collected packages: psutil 07:38:54 INFO - Running setup.py install for psutil 07:38:54 INFO - building 'psutil._psutil_linux' extension 07:38:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:38:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:38:54 INFO - building 'psutil._psutil_posix' extension 07:38:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:38:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:38:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:38:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:38:54 INFO - Successfully installed psutil 07:38:54 INFO - Cleaning up... 07:38:54 INFO - Return code: 0 07:38:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:38: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')]} 07:38:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38: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')]} 07:38:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb0f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdce3b0>, '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 0xdcf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcf740>, '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': '52faae308a556c440401f8e5000001e8-1467988714.434558-1910852929', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:38: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:38: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 mozsystemmonitor==0.3 07:38:54 INFO - Using env: {'DISPLAY': ':0', 07:38:54 INFO - 'HOME': '/home/cltbld', 07:38:54 INFO - 'LANG': 'en_US.UTF-8', 07:38:54 INFO - 'LANGUAGE': 'en_US:en', 07:38:54 INFO - 'LOGNAME': 'cltbld', 07:38:54 INFO - 'MAIL': '/var/mail/cltbld', 07:38:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:54 INFO - 'MOZ_NO_REMOTE': '1', 07:38:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:54 INFO - 'NO_EM_RESTART': '1', 07:38:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:54 INFO - 'PWD': '/builds/slave/test', 07:38:54 INFO - 'SHELL': '/bin/bash', 07:38:54 INFO - 'SHLVL': '1', 07:38:54 INFO - 'TERM': 'linux', 07:38:54 INFO - 'TMOUT': '86400', 07:38:54 INFO - 'USER': 'cltbld', 07:38:54 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467988714.434558-1910852929', 07:38:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:54 INFO - '_': '/tools/buildbot/bin/python'} 07:38:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:38:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:38:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:38:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:38:57 INFO - Installing collected packages: mozsystemmonitor 07:38:57 INFO - Running setup.py install for mozsystemmonitor 07:38:57 INFO - Successfully installed mozsystemmonitor 07:38:57 INFO - Cleaning up... 07:38:57 INFO - Return code: 0 07:38:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:38:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:57 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 0xb0f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdce3b0>, '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 0xdcf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcf740>, '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': '52faae308a556c440401f8e5000001e8-1467988714.434558-1910852929', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:38:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:38:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:38:57 INFO - Using env: {'DISPLAY': ':0', 07:38:57 INFO - 'HOME': '/home/cltbld', 07:38:57 INFO - 'LANG': 'en_US.UTF-8', 07:38:57 INFO - 'LANGUAGE': 'en_US:en', 07:38:57 INFO - 'LOGNAME': 'cltbld', 07:38:57 INFO - 'MAIL': '/var/mail/cltbld', 07:38:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:57 INFO - 'MOZ_NO_REMOTE': '1', 07:38:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:57 INFO - 'NO_EM_RESTART': '1', 07:38:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:57 INFO - 'PWD': '/builds/slave/test', 07:38:57 INFO - 'SHELL': '/bin/bash', 07:38:57 INFO - 'SHLVL': '1', 07:38:57 INFO - 'TERM': 'linux', 07:38:57 INFO - 'TMOUT': '86400', 07:38:57 INFO - 'USER': 'cltbld', 07:38:57 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467988714.434558-1910852929', 07:38:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:57 INFO - '_': '/tools/buildbot/bin/python'} 07:38:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:57 INFO - Downloading/unpacking jsonschema==2.5.1 07:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:38:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:38: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 07:38: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 07:38: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 07:38: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 07:38: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 07:38: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 07:38:59 INFO - Downloading functools32-3.2.3-2.tar.gz 07:38:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:38:59 INFO - warning: no files found matching '*.txt' 07:38:59 INFO - no previously-included directories found matching 'build' 07:38:59 INFO - no previously-included directories found matching 'dist' 07:38:59 INFO - no previously-included directories found matching '.git*' 07:38:59 INFO - Installing collected packages: jsonschema, functools32 07:38:59 INFO - Running setup.py install for functools32 07:38:59 INFO - warning: no files found matching '*.txt' 07:38:59 INFO - no previously-included directories found matching 'build' 07:38:59 INFO - no previously-included directories found matching 'dist' 07:38:59 INFO - no previously-included directories found matching '.git*' 07:38:59 INFO - Successfully installed jsonschema functools32 07:38:59 INFO - Cleaning up... 07:38:59 INFO - Return code: 0 07:38:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:38:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:59 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 0xb0f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdce3b0>, '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 0xdcf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcf740>, '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': '52faae308a556c440401f8e5000001e8-1467988714.434558-1910852929', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:38:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:38:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:38:59 INFO - Using env: {'DISPLAY': ':0', 07:38:59 INFO - 'HOME': '/home/cltbld', 07:38:59 INFO - 'LANG': 'en_US.UTF-8', 07:38:59 INFO - 'LANGUAGE': 'en_US:en', 07:38:59 INFO - 'LOGNAME': 'cltbld', 07:38:59 INFO - 'MAIL': '/var/mail/cltbld', 07:38:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:59 INFO - 'MOZ_NO_REMOTE': '1', 07:38:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:59 INFO - 'NO_EM_RESTART': '1', 07:38:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:59 INFO - 'PWD': '/builds/slave/test', 07:38:59 INFO - 'SHELL': '/bin/bash', 07:38:59 INFO - 'SHLVL': '1', 07:38:59 INFO - 'TERM': 'linux', 07:38:59 INFO - 'TMOUT': '86400', 07:38:59 INFO - 'USER': 'cltbld', 07:38:59 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467988714.434558-1910852929', 07:38:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:59 INFO - '_': '/tools/buildbot/bin/python'} 07:38:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:59 INFO - Downloading/unpacking blobuploader==1.2.4 07:38: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 07:38: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 07:38: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 07:38: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 07:38: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 07:38: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 07:39:01 INFO - Downloading blobuploader-1.2.4.tar.gz 07:39:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:39:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:39:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:39:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:39:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:39:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:39:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:39:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:39:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:39:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:39:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:39:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:39:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:39:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:39:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:39:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:39:02 INFO - Downloading docopt-0.6.1.tar.gz 07:39:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:39:02 INFO - Installing collected packages: blobuploader, requests, docopt 07:39:02 INFO - Running setup.py install for blobuploader 07:39:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:39:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:39:02 INFO - Running setup.py install for requests 07:39:03 INFO - Running setup.py install for docopt 07:39:03 INFO - Successfully installed blobuploader requests docopt 07:39:03 INFO - Cleaning up... 07:39:03 INFO - Return code: 0 07:39:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:39: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')]} 07:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:39:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:39: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')]} 07:39:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:39:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:39:03 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 0xb0f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdce3b0>, '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 0xdcf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcf740>, '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': '52faae308a556c440401f8e5000001e8-1467988714.434558-1910852929', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:39:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:39:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:39:03 INFO - Using env: {'DISPLAY': ':0', 07:39:03 INFO - 'HOME': '/home/cltbld', 07:39:03 INFO - 'LANG': 'en_US.UTF-8', 07:39:03 INFO - 'LANGUAGE': 'en_US:en', 07:39:03 INFO - 'LOGNAME': 'cltbld', 07:39:03 INFO - 'MAIL': '/var/mail/cltbld', 07:39:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:39:03 INFO - 'MOZ_NO_REMOTE': '1', 07:39:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:39:03 INFO - 'NO_EM_RESTART': '1', 07:39:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:39:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:39:03 INFO - 'PWD': '/builds/slave/test', 07:39:03 INFO - 'SHELL': '/bin/bash', 07:39:03 INFO - 'SHLVL': '1', 07:39:03 INFO - 'TERM': 'linux', 07:39:03 INFO - 'TMOUT': '86400', 07:39:03 INFO - 'USER': 'cltbld', 07:39:03 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467988714.434558-1910852929', 07:39:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:39:03 INFO - '_': '/tools/buildbot/bin/python'} 07:39:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:39:03 INFO - Running setup.py (path:/tmp/pip-YBjJdY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:39:03 INFO - Running setup.py (path:/tmp/pip-QVYkiw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:39:03 INFO - Running setup.py (path:/tmp/pip-tg7X7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:39:03 INFO - Running setup.py (path:/tmp/pip-L2ZmvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:39:03 INFO - Running setup.py (path:/tmp/pip-sCoMDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:39:03 INFO - Running setup.py (path:/tmp/pip-KJy9Vx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:39:04 INFO - Running setup.py (path:/tmp/pip-SIPJY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:39:04 INFO - Running setup.py (path:/tmp/pip-i91C74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:39:04 INFO - Running setup.py (path:/tmp/pip-_FUb6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:39:04 INFO - Running setup.py (path:/tmp/pip-I4rwnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:39:04 INFO - Running setup.py (path:/tmp/pip-1jCeBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:39:04 INFO - Running setup.py (path:/tmp/pip-Rk93V_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:39:04 INFO - Running setup.py (path:/tmp/pip-KNXZFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:39:04 INFO - Running setup.py (path:/tmp/pip-77bsek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:39:04 INFO - Running setup.py (path:/tmp/pip-XZtRQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:39:04 INFO - Running setup.py (path:/tmp/pip-zth84S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:39:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:39:04 INFO - Running setup.py (path:/tmp/pip-4V61RY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:39:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:39:04 INFO - Running setup.py install for manifestparser 07:39:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:39:04 INFO - Running setup.py install for mozcrash 07:39:05 INFO - Running setup.py install for mozdebug 07:39:05 INFO - Running setup.py install for mozdevice 07:39:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:39:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:39:05 INFO - Running setup.py install for mozfile 07:39:05 INFO - Running setup.py install for mozhttpd 07:39:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:39:05 INFO - Running setup.py install for mozinfo 07:39:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:39:05 INFO - Running setup.py install for mozInstall 07:39:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:39:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:39:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:39:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:39:05 INFO - Running setup.py install for mozleak 07:39:05 INFO - Running setup.py install for mozlog 07:39:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:39:05 INFO - Running setup.py install for moznetwork 07:39:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:39:05 INFO - Running setup.py install for mozprocess 07:39:06 INFO - Running setup.py install for mozprofile 07:39:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:39:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:39:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:39:06 INFO - Running setup.py install for mozrunner 07:39:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:39:06 INFO - Running setup.py install for mozscreenshot 07:39:06 INFO - Running setup.py install for moztest 07:39:06 INFO - Running setup.py install for mozversion 07:39:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:39:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:39:06 INFO - Cleaning up... 07:39:06 INFO - Return code: 0 07:39:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:39:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:39:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:39:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:39:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:39:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:39:06 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 0xb0f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdce3b0>, '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 0xdcf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcf740>, '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': '52faae308a556c440401f8e5000001e8-1467988714.434558-1910852929', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:39:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:39:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:39:06 INFO - Using env: {'DISPLAY': ':0', 07:39:06 INFO - 'HOME': '/home/cltbld', 07:39:06 INFO - 'LANG': 'en_US.UTF-8', 07:39:06 INFO - 'LANGUAGE': 'en_US:en', 07:39:06 INFO - 'LOGNAME': 'cltbld', 07:39:06 INFO - 'MAIL': '/var/mail/cltbld', 07:39:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:39:06 INFO - 'MOZ_NO_REMOTE': '1', 07:39:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:39:06 INFO - 'NO_EM_RESTART': '1', 07:39:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:39:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:39:06 INFO - 'PWD': '/builds/slave/test', 07:39:06 INFO - 'SHELL': '/bin/bash', 07:39:06 INFO - 'SHLVL': '1', 07:39:06 INFO - 'TERM': 'linux', 07:39:06 INFO - 'TMOUT': '86400', 07:39:06 INFO - 'USER': 'cltbld', 07:39:06 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467988714.434558-1910852929', 07:39:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:39:06 INFO - '_': '/tools/buildbot/bin/python'} 07:39:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:39:06 INFO - Running setup.py (path:/tmp/pip-Vk_ZhM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:39:06 INFO - Running setup.py (path:/tmp/pip-ZBE2Rx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:39:06 INFO - Running setup.py (path:/tmp/pip-RRpPvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:39:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:39:07 INFO - Running setup.py (path:/tmp/pip-YY_Irr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:39:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:39:07 INFO - Running setup.py (path:/tmp/pip-FOkhPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:39:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:39:07 INFO - Running setup.py (path:/tmp/pip-mJuQ8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:39:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:39:07 INFO - Running setup.py (path:/tmp/pip-qrXyiw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:39:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:39:07 INFO - Running setup.py (path:/tmp/pip-WLT5mU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:39:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:39:07 INFO - Running setup.py (path:/tmp/pip-QlfrNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:39:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:39:07 INFO - Running setup.py (path:/tmp/pip-dCV0nV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:39:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:39:07 INFO - Running setup.py (path:/tmp/pip-eA4dnS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:39:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:39:07 INFO - Running setup.py (path:/tmp/pip-9Lhn9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:39:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:39:07 INFO - Running setup.py (path:/tmp/pip-tIjaR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:39:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:39:07 INFO - Running setup.py (path:/tmp/pip-NAhDsP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:39:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:39:07 INFO - Running setup.py (path:/tmp/pip-ZM7gKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:39:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:39:07 INFO - Running setup.py (path:/tmp/pip-vZqmMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:39:08 INFO - Running setup.py (path:/tmp/pip-tcB7L7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:39:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:39:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:39:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:39:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:39:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:39:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:39:09 INFO - Downloading blessings-1.6.tar.gz 07:39:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:39:10 INFO - Installing collected packages: blessings 07:39:10 INFO - Running setup.py install for blessings 07:39:10 INFO - Successfully installed blessings 07:39:10 INFO - Cleaning up... 07:39:10 INFO - Return code: 0 07:39:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:39:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:39:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:39:10 INFO - Reading from file tmpfile_stdout 07:39:10 INFO - Current package versions: 07:39:10 INFO - argparse == 1.2.1 07:39:10 INFO - blessings == 1.6 07:39:10 INFO - blobuploader == 1.2.4 07:39:10 INFO - docopt == 0.6.1 07:39:10 INFO - functools32 == 3.2.3-2 07:39:10 INFO - jsonschema == 2.5.1 07:39:10 INFO - manifestparser == 1.1 07:39:10 INFO - mozInstall == 1.12 07:39:10 INFO - mozcrash == 0.17 07:39:10 INFO - mozdebug == 0.1 07:39:10 INFO - mozdevice == 0.48 07:39:10 INFO - mozfile == 1.2 07:39:10 INFO - mozhttpd == 0.7 07:39:10 INFO - mozinfo == 0.9 07:39:10 INFO - mozleak == 0.1 07:39:10 INFO - mozlog == 3.2 07:39:10 INFO - moznetwork == 0.27 07:39:10 INFO - mozprocess == 0.23 07:39:10 INFO - mozprofile == 0.28 07:39:10 INFO - mozrunner == 6.12 07:39:10 INFO - mozscreenshot == 0.1 07:39:10 INFO - mozsystemmonitor == 0.3 07:39:10 INFO - moztest == 0.7 07:39:10 INFO - mozversion == 1.4 07:39:10 INFO - psutil == 3.1.1 07:39:10 INFO - requests == 1.2.3 07:39:10 INFO - wsgiref == 0.1.2 07:39:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:39:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:39:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:39:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:39:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:39:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:39:10 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 0xb0f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdce3b0>, '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 0xdcf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcf740>, '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': '52faae308a556c440401f8e5000001e8-1467988714.434558-1910852929', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:39:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:39:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:39:10 INFO - Using env: {'DISPLAY': ':0', 07:39:10 INFO - 'HOME': '/home/cltbld', 07:39:10 INFO - 'LANG': 'en_US.UTF-8', 07:39:10 INFO - 'LANGUAGE': 'en_US:en', 07:39:10 INFO - 'LOGNAME': 'cltbld', 07:39:10 INFO - 'MAIL': '/var/mail/cltbld', 07:39:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:39:10 INFO - 'MOZ_NO_REMOTE': '1', 07:39:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:39:10 INFO - 'NO_EM_RESTART': '1', 07:39:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:39:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:39:10 INFO - 'PWD': '/builds/slave/test', 07:39:10 INFO - 'SHELL': '/bin/bash', 07:39:10 INFO - 'SHLVL': '1', 07:39:10 INFO - 'TERM': 'linux', 07:39:10 INFO - 'TMOUT': '86400', 07:39:10 INFO - 'USER': 'cltbld', 07:39:10 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467988714.434558-1910852929', 07:39:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:39:10 INFO - '_': '/tools/buildbot/bin/python'} 07:39:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:39:10 INFO - Cleaning up... 07:39:10 INFO - Return code: 0 07:39:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:39:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:39:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:39:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:39:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:39:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:39:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb0f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdce3b0>, '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 0xdcf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcf740>, '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': '52faae308a556c440401f8e5000001e8-1467988714.434558-1910852929', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:39:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:39:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:39:10 INFO - Using env: {'DISPLAY': ':0', 07:39:10 INFO - 'HOME': '/home/cltbld', 07:39:10 INFO - 'LANG': 'en_US.UTF-8', 07:39:10 INFO - 'LANGUAGE': 'en_US:en', 07:39:10 INFO - 'LOGNAME': 'cltbld', 07:39:10 INFO - 'MAIL': '/var/mail/cltbld', 07:39:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:39:10 INFO - 'MOZ_NO_REMOTE': '1', 07:39:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:39:10 INFO - 'NO_EM_RESTART': '1', 07:39:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:39:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:39:10 INFO - 'PWD': '/builds/slave/test', 07:39:10 INFO - 'SHELL': '/bin/bash', 07:39:10 INFO - 'SHLVL': '1', 07:39:10 INFO - 'TERM': 'linux', 07:39:10 INFO - 'TMOUT': '86400', 07:39:10 INFO - 'USER': 'cltbld', 07:39:10 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467988714.434558-1910852929', 07:39:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:39:10 INFO - '_': '/tools/buildbot/bin/python'} 07:39:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:39:10 INFO - Cleaning up... 07:39:10 INFO - Return code: 0 07:39:10 INFO - Running post-action listener: _resource_record_post_action 07:39:10 INFO - Running post-action listener: _start_resource_monitoring 07:39:10 INFO - Starting resource monitoring. 07:39:10 INFO - ##### 07:39:10 INFO - ##### Finished create-virtualenv step (success) 07:39:10 INFO - ##### 07:39:10 INFO - ##### 07:39:10 INFO - ##### Running install step. 07:39:10 INFO - ##### 07:39:10 INFO - Running pre-action listener: _resource_record_pre_action 07:39:10 INFO - Running main action method: install 07:39:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:39:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:39:11 INFO - Reading from file tmpfile_stdout 07:39:11 INFO - Detecting whether we're running mozinstall >=1.0... 07:39:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:39:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:39:11 INFO - Reading from file tmpfile_stdout 07:39:11 INFO - Output received: 07:39:11 INFO - Usage: mozinstall [options] installer 07:39:11 INFO - Options: 07:39:11 INFO - -h, --help show this help message and exit 07:39:11 INFO - -d DEST, --destination=DEST 07:39:11 INFO - Directory to install application into. [default: 07:39:11 INFO - "/builds/slave/test"] 07:39:11 INFO - --app=APP Application being installed. [default: firefox] 07:39:11 INFO - mkdir: /builds/slave/test/build/application 07:39:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:39:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:39:27 INFO - Reading from file tmpfile_stdout 07:39:27 INFO - Output received: 07:39:27 INFO - /builds/slave/test/build/application/firefox/firefox 07:39:27 INFO - Running post-action listener: _resource_record_post_action 07:39:27 INFO - ##### 07:39:27 INFO - ##### Finished install step (success) 07:39:27 INFO - ##### 07:39:27 INFO - ##### 07:39:27 INFO - ##### Running run-tests step. 07:39:27 INFO - ##### 07:39:27 INFO - Running pre-action listener: _resource_record_pre_action 07:39:27 INFO - Running main action method: run_tests 07:39:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:39:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:39:27 INFO - Python 2.7.3 07:39:27 INFO - Return code: 0 07:39:27 INFO - grabbing minidump binary from tooltool 07:39:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:39:27 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 0xdce3b0>, '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 0xdcf2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdcf740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:39:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:39:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:39:27 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:39:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:39:27 INFO - Return code: 0 07:39:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:39:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:39:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:39:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:39:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:39:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VrFiOJmLRLegbNzi_YLCtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:39:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VrFiOJmLRLegbNzi_YLCtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:39:27 INFO - Using env: {'DISPLAY': ':0', 07:39:27 INFO - 'HOME': '/home/cltbld', 07:39:27 INFO - 'LANG': 'en_US.UTF-8', 07:39:27 INFO - 'LANGUAGE': 'en_US:en', 07:39:27 INFO - 'LOGNAME': 'cltbld', 07:39:27 INFO - 'MAIL': '/var/mail/cltbld', 07:39:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:39:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:39:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:39:27 INFO - 'MOZ_NO_REMOTE': '1', 07:39:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:39:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:39:27 INFO - 'NO_EM_RESTART': '1', 07:39:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:39:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:39:27 INFO - 'PWD': '/builds/slave/test', 07:39:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:39:27 INFO - 'SHELL': '/bin/bash', 07:39:27 INFO - 'SHLVL': '1', 07:39:27 INFO - 'TERM': 'linux', 07:39:27 INFO - 'TMOUT': '86400', 07:39:27 INFO - 'USER': 'cltbld', 07:39:27 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1467988714.434558-1910852929', 07:39:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:39:27 INFO - '_': '/tools/buildbot/bin/python'} 07:39:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VrFiOJmLRLegbNzi_YLCtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:39:27 INFO - mozversion application_buildid: 20160708070926 07:39:27 INFO - mozversion application_changeset: a2df0e1a03d970d20d89ad57c5748ab5d26f2e1e 07:39:27 INFO - mozversion application_display_name: Nightly 07:39:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:39:27 INFO - mozversion application_name: Firefox 07:39:27 INFO - mozversion application_remotingname: firefox 07:39:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:39:27 INFO - mozversion application_vendor: Mozilla 07:39:27 INFO - mozversion application_version: 50.0a1 07:39:27 INFO - mozversion platform_buildid: 20160708070926 07:39:27 INFO - mozversion platform_changeset: a2df0e1a03d970d20d89ad57c5748ab5d26f2e1e 07:39:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:39:27 INFO - mozversion platform_version: 50.0a1 07:39:27 INFO - using testdate: 1467988767 07:39:27 INFO - actual date: 1467988767 07:39:27 INFO - starting webserver on 'localhost:48303' 07:39:27 INFO - SUITE-START | Running 2 tests 07:39:27 INFO - TEST-START | dromaeo_css 07:39:27 INFO - operating with platform_type : linux_ 07:39:27 INFO - Initialising browser for dromaeo_css test... 07:39:27 INFO - TEST-INFO | started process 14736 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqvX3SD/profile http://localhost:48303/getInfo.html) 07:39:32 INFO - PROCESS | 14736 | __metrics Screen width/height:1600/1200 07:39:32 INFO - PROCESS | 14736 | colorDepth:24 07:39:32 INFO - PROCESS | 14736 | Browser inner width/height: 1024/697 07:39:32 INFO - PROCESS | 14736 | __metrics 07:39:33 INFO - PROCESS | 14736 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:39:34 INFO - TEST-INFO | 14736: exit 0 07:39:34 INFO - Browser initialized. 07:39:34 INFO - Running cycle 1/1 for dromaeo_css test... 07:39:34 INFO - TEST-INFO | started process 14817 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqvX3SD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:39:45 INFO - PROCESS | 14817 | RSS: Main: 158994432 07:39:45 INFO - PROCESS | 14817 | 07:40:37 INFO - PROCESS | 14817 | 1467988837723 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:42:49 INFO - PROCESS | 14817 | Cycle 1(1): loaded http://localhost:48303/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48303/tests/dromaeo/cssquery-ext.html) 07:42:50 INFO - PROCESS | 14817 | RSS: Main: 264785920 07:42:50 INFO - PROCESS | 14817 | 07:45:53 INFO - PROCESS | 14817 | Cycle 1(1): loaded http://localhost:48303/tests/dromaeo/cssquery-ext.html (next: http://localhost:48303/tests/dromaeo/cssquery-jquery.html) 07:45:54 INFO - PROCESS | 14817 | RSS: Main: 241139712 07:45:54 INFO - PROCESS | 14817 | 07:48:56 INFO - PROCESS | 14817 | Cycle 1(1): loaded http://localhost:48303/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48303/tests/dromaeo/cssquery-mootools.html) 07:48:57 INFO - PROCESS | 14817 | RSS: Main: 228356096 07:48:57 INFO - PROCESS | 14817 | 07:51:59 INFO - PROCESS | 14817 | Cycle 1(1): loaded http://localhost:48303/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48303/tests/dromaeo/cssquery-prototype.html) 07:51:59 INFO - PROCESS | 14817 | RSS: Main: 229539840 07:51:59 INFO - PROCESS | 14817 | 07:55:03 INFO - PROCESS | 14817 | Cycle 1(1): loaded http://localhost:48303/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48303/tests/dromaeo/cssquery-yui.html) 07:55:03 INFO - PROCESS | 14817 | RSS: Main: 214392832 07:55:03 INFO - PROCESS | 14817 | 07:58:06 INFO - PROCESS | 14817 | Cycle 1(1): loaded http://localhost:48303/tests/dromaeo/cssquery-yui.html (next: http://localhost:48303/tests/dromaeo/cssquery-dojo.html) 07:58:06 INFO - PROCESS | 14817 | RSS: Main: 268509184 07:58:06 INFO - PROCESS | 14817 | 07:58:06 INFO - PROCESS | 14817 | __start_tp_report 07:58:06 INFO - PROCESS | 14817 | _x_x_mozilla_page_load 07:58:06 INFO - PROCESS | 14817 | _x_x_mozilla_page_load_details 07:58:06 INFO - PROCESS | 14817 | |i|pagename|runs| 07:58:06 INFO - PROCESS | 14817 | |0;dojo.html;2618.2276228512587;2621.5936529837873;2647.3646324882034;2653.296876327772;2667.3065003099186;4605.608523275526;4695.6478264130155;4749.8812529686775;4750.833720819768;4775.689580177291;4703.3180188872675;4709.717416954976;4731.1956967315555;4743.4545027321865;4789.832355867546;4281.422008028923;4295.935560966573;4364.498082720496;4388.253996820532;4390.626796722267;4417.867463976086;4460.910781784362;4482.417285752847;4501.054778496519;4512.16524942885;4252.596003379674;4282.314829627276;4295;4393.406890069831;4440.911181776346;4319.611234988866;4335.761533115678;4340.739555626673;4390.1878152541885;4417.293233082723;4327.502337231227;4330.826766929351;4375.1031038637;4387.122575484916;4413.029133590605;4737.147313483571;4754.976225118887;4793.520647935214;4800.207965685692;4811.855644330676;4864.173090574611;4956.4547899731;5037.143685573461;5041.344625198737;5158.92261616076;5128.5640720538795;5148.768305426265;5150.098732721796;5151.330327057496;5183.222516622499;4529.479109902403;4769.260764581495;4781.019890922353;4802.27965805125;4820.132376172288;5139.12634852076;5194.1429664105;5214.452482489284;5216.765245563959;5274.156135018378;5021.046001259749;5044.520770526794;5055.241713742968;5068.949310506848;5073.7716802743225;4935.284383764334;5024.145895197825;5078.314427552307;5137.845864624067;5144.639875208774;4959.925601115986;4967.90064198714;4981.277714731416;4986.800527978913;5040.168372218616;4929.2359684248995;4964.801407943714;4997.7251251180805;5011.949880501148;5025.623078269145;4173.10278290163;4210.073783767566;4218.704690671623;4279.957200428018;4315.741055536615;3697.352963231424;3736.75711078779;3766.114962983697;3774.7735135891385;3821.2357528494413;4354.325079612665;4367.039251364695;4370.606645401929;4402.625776808943;4403.2734598791485;4890.315355850184;5136.794528218904;5136.922946155811;5157.149070403417;5181.715005674724;4218.409422680827;4283.929017745563;4324.372965919924;4342.457192850894;4355.259605867011;4552.681312308173;4554.681172317906;4561.29299958507;4563.680542362069;4602.125596136723;4647.117047760915;4825.420949486084;4838.854834354905;4844.975775121102;4853.02939412119;5061.291419201389;5102.36220472441;5114.181730923035;5129.820456284012;5135.743212839268;4795.088933102699;4812.807487700453;4819.469858315512;4840.177169881058;4870.756462176948;4851.51484851512;4940.629452790983;5044.974775126101;5079.568236699774;5126.307948426915;5043.773030213576;5057.974710126426;5077.365329333833;5093.821716239914;5131.127708289674;4912.901741965212;4930.359053323045;4939.53074457926;4956.925646115239;4981.153203955264;4833.250846118857;4840.491748366511;4888.535589119028;4976.850694479172;5003.574696150722;4901.705897646153;4920.188168952226;4933.309336692938;4954.777035033504;4958.727270000185;4987.326710893983;5003.724795136302;5005.923726398842;5008.899822003613;5048.192289233852;4677.438707355139;4794.400699912511;4858.319835223142;4862.07620552094;4890.657653964188 07:58:06 INFO - PROCESS | 14817 | |1;ext.html;545.1814489958648;583.2097507876827;595.2559300873908;604.0637012630425;618.7308520793458;29831.105066848002;40007.39988900165;40754.7962260189;40872.18255634885;44986.325205121866;41513.37729934054;41634.791826040906;41647.375289370684;41883.162336753325;41904;7496.100467943855;7589.316961473466;7592.164861865191;7831.882521762164;7979.920200798005;7543;10020.498975051254;10269.28115031948;10276.383416995004;10595.470226488645;10428.217883658755;10469.11012563933;10470.319429237114;10473.947630261839;10507.2644914856;7484.625768711597;7698.846023079563;10014.849777253346;10055;10070.496475176213;7701.576413297266;9882.55528501212;10231.488425578691;10253.231007674454;10522.210834187466;39098.804505977285;39449.60550394488;39505.20989580221;39531.209375812614;39637.61268355593;2807.887684492618;2895.420915816845;2933.897313594014;3063.1576316512915;3251.9674803252137;29282.925292844157;29966.250843728863;30037.399252015057;30037.4636046547;30724.8463757682;3071.279400696792;3095.3809238152458;3129.0769223079246;3133.6552979172275;3172.587563616738;188221;188360;188531;188824;189049.99999999863;54528.636784080714;54913;55570.44429555733;55603.16595250994;55682.16476752852;57049.71475142598;57060.291081080424;57244.71377643085;57299.567510812565;57309;12984.285864277555;13457.25985070811;13463.730725385438;13495.662608434868;13496.460141594423;9490.810183796286;9874.80250394988;9893.159081478156;10129.544170512198;10484.737881553023;17351.65296694059;17489;17493.475195744148;17499.300027998994;17517.211725472385;6430.549861509743;6446.8388290293115;6487.7080531376205;6513.446357059703;6527;744.8361360500681;765.6784150656738;780.1184661332771;804.5574933786394;827.5324441690426;24570.140045098335;25365.365865853502;25693;25771.226863194133;25806.354841129123;911.2391153386864;935.6444551070549;941.2799208605422;1017.1811691588194;1066.7973085113804;13679.24764137982;14167.128932561953;14397.78403323951;14492.782608260884;14539.92730036343;196049;196617;196854;197242;198101;49960.25059624109;50015.749921250164;50104.498955009985;50144.247836282484;50266.246006309935;1044.4673216659558;1050.175612144463;1058.2909450668226;1135.6082151657665;1204.175140029083;28481.43037139287;29521.557176642797;29894.70105299006;30162.24594385158;30600;42469;42803.357949631405;43081.353779692705;43196;43234.56765432305;296559;297255;297534;297723;297944;27994.72005279921;28682.56976145401;36539.817300913324;37114.62885371112;37207.441888371155;39797.60202397939;40378;40619.18761624692;40711.79644101761;40721.592784072964;35337;35553;35555;35885.28229435449;36084.63915360813;35100.64899350974;35234.59567554056;35551.288974220886;35729.46405803863;36047.098822529646;34690.65309346975;35078;35209.47185792164;35340.64659353373;35832.46251306285;31303.84348078245;31651.863414439493;31715.20711982219;31838.681613184497;31945.520817187295;24301.14945976882;24466;24719.50560988806;25067.493250674786;25154.874225628755 07:58:06 INFO - PROCESS | 14817 | |2;jquery.html;333.55970119442344;373.689837434929;375.45558939537676;381.31744177921524;388.1402693034927;12831.55089571864;16358.263878125483;16498.42255521057;17413.216405261763;18342.174602142903;16441.26014329355;16832.55927890455;17175.742363864552;17341.653166936685;17346;4455.175792478386;5048.495150484959;5274.683518988853;5275.525202731754;5278.577713782888;3717.1636381814146;5994.220751302325;6295.937040629581;6300.905486417684;6410.423061924426;6105.633661980273;6306.495480361583;6333.303336632966;6353.2693740219775;6364.618122912617;6303.086052522382;6309.526785491106;6316.778912738032;6342.999999999977;6351.237851457809;5350.0904846176245;5519.227308176858;5615.550755939515;5618.8314350569135;5625.156226566048;17487.825121748872;17614.2073606688;18490;21490.89254553733;21689;1921.7213504041974;1962.460323411059;1974.3978086683555;1987.791281915407;2002.1991203518564;13726;13770.65573360664;13827.723445531134;13851.16892986424;13851.515196968057;1729.8183690712547;1735.0977491704243;1759.6304775996928;1789.2127463915836;1856.2296646891523;67897.32102679009;68205.65897170482;68446.31553684449;69009.65495172542;69718;9005.414648047856;9340.252779777602;10102.494875256209;10110.140638045701;10194.388336699822;13605.523806666719;13704.383302751201;13729.931350343184;13738.725225495435;13759;7202.96398518004;7205.099362579677;7271.454640901953;7317.926820731831;7356.37470814976;6796.320367963263;6914.896276555855;6946.340097690812;6951.65241737911;7137.536060156073;5461.208124821878;6091.365565538996;6213.844653883599;6260.186175797208;6307.5584709070845;1604.6710424362977;1648.4642491190411;1700.9574760631083;1713.9400120995706;1722.1647500962024;836.5190015740851;838.9035260945069;839.6221700234919;856.6873091321622;951.1629765806184;16720.916395417946;17317.393891213746;17629.294828206726;17928.462146135636;17974.91012544929;833.1127349372898;853.2661910756744;859.3984211052289;874.6851133591902;880.823835232956;9826.4104153751;10174.13519850821;10308.793824123475;10316.948415257875;10465.84301235482;369041;384681;385334;386047;386096;71447;71884.2811571888;72868.2713172872;73007.63496182485;73565.26434735692;824.2046425199711;879.9032106468284;941.261110028638;942.0297093993198;944.4616568555995;16008.599785005003;16370.67258654844;16411.91794041022;16630.25163867653;16956.23696933616;38596.421053683654;39237.99999999886;39539.80230098831;40826.38760418655;40927.38608920928;54874.451255486936;55807;56342;56557.71721141368;57151.714241428526;7729.1884352142215;7761.611919403895;7856.960715196387;7874.960625196837;8103.392245581487;8792.384533082623;10513.684589462327;12001.81997270059;12231;12249.265044097383;10678.8932110681;10756.139508839431;10775.137988961022;10962.232643714864;11207;10387.117095047006;10439.739006524898;10463.110635595755;10706.839397408889;10813.513391897226;10467.790644187226;10540.841887371542;10724.946375268073;11003.559857605926;11044.502997364978;7878.4091193161885;7952.204779522233;8016.198380161937;8078.313343365645;8244.670213191404;9780.559874805509;9966.202703783534;10136.138428233682;10145.137663298703;10166.644167454104 07:58:06 INFO - PROCESS | 14817 | |3;mootools.html;1349.8447678516973;1394.4004078246355;1462.7513322735133;1671.6573102513985;1703.4889533140047;7548.094228692551;8022.117567067632;8075.192480751929;8087.3934454915825;8092.352611791065;6799.4560435165195;7360.9631951840165;7577.962110189442;7586.886196707053;7754.030746156731;2206.249875042485;2236.317923033474;2238.328501449567;2239.2498512998163;2245.315178870444;1845.1235663060074;2141.2077531313435;2165.6426689596196;2194.9451263718374;2226.6214743493565;2177.912883484659;2209.0942713487475;2216.423729830248;2216.8226541876693;2225.5660146271484;2178.880161591112;2187.3984654220058;2204.2946257197705;2217.5897458970144;2219.6448568229166;2145.8068773810433;2148.871067735941;2152.860064095829;2159.75162856272;2189.9452513687124;7955.562444065574;8028.11690714021;8030.959845200795;8052.154523775036;8055.3958453115665;4554.362389265505;4568.88577785558;4630.490646028934;4636.420447444069;4715.7877895494785;2717.429339838636;2808.3540785619216;2828.7595554377904;2851.9429611407863;2860.284928767808;868.6004437958546;899.4872922434215;903.2773780975193;905.8233644439337;908.3414524469773;10686.572537098507;10691.78616427675;10718.35689858611;10719.142468602493;10723.410212438313;4004.3392840181045;4172.123853990635;4348.391225228471;4350.695451318441;4359.237133501624;9200.723978280663;9218.86171707425;9219.21636660878;9225;9225.215856652125;4718.598919091915;4730.95269047312;4740.502247264057;4749.1926372516755;4757.762111894392;4248.192843359813;4307.375430562551;4315.978420107942;4320.373545835836;4320.891977700519;3631.128529153037;3668.944965825515;3708.38811596089;3730.6828919542145;3776.2069965307046;1089.2701889733896;1180.8228765685044;1183.627157445402;1197.868234494205;1205.9397030148457;716.8136284565946;738.800523858566;748.0761259844088;755.7279379423403;787.5314188058096;4960.355153829979;5012.373453318335;5028.069807085701;5064.240363945438;5092.618053645917;816.2898278497745;844.966201351939;848.1687945813138;855.4985999570714;929.6420877961898;3331.93336133276;3364.747643926715;3369.107186595554;3421.5380923575494;3458.291050334675;9522;9854.950725246328;9949.602015919281;9950.009998000429;9966.15287700539;9786.902130978742;9841.655542056136;9842.163416109568;9854.753631159278;9868.605255789687;6785.898211526831;7105.502614816914;7131.536450130621;7229.385502232264;7243.674034668347;5078.822241221539;5080.26336181259;5293.761780719799;5336.839894803162;5350.9732451337495;8749;9056.501892395981;9170.403923744936;9195.310351723781;9195.54022298869;9077.137671921157;9148.771280718036;9231.538423078953;9411.811763764823;9415.340926135104;6596.175478065242;6920.204176519765;6942.132233470817;7031.7890463286185;7092.184398794205;7584.355329797029;7595.810104747426;7629.504082234637;7645.159032506309;7651.3496352810635;6565.934340656532;6755;6850.6574671267235;6874.346937040973;6936.757213497705;6818.8636227276165;6835.111435513351;6890.138732658418;7025.332593403618;7090.255523169993;6192.628442293477;6256;6306.842328941813;6310.873782524232;6311.116443697978;4237.406763053236;4279.700420970502;4314.827406903689;4329.15581461612;4353.368761529624;4388.2320593896575;4438.733675979452;4446.599806017474;4473.105378924293;4480.126375356775 07:58:06 INFO - PROCESS | 14817 | |4;prototype.html;305.4364697133788;306.7132231363674;308.03584779639726;308.08345173109996;310.9207152176198;4795.68828026178;4801.327814106019;4811.374521312233;4813.109574728677;4815.109204797115;4762.476127625959;4781.16329642312;4789.5210478952085;4794.256890182019;4817.783199756011;3603.8466341950793;3688.926221475582;3752.9437058444146;3806.71449641278;3837.5970523095093;3759.9812000939955;3822.8661996830115;3845.4616353710503;3846.3653497173073;3862.7059934921836;3783.772973621578;3788.602196769341;3790.4503846942175;3802.505674262342;3807.9048023799487;3616.8553257869785;3633.927321453556;3733.4586484959527;3755.511783468159;3759.1353988582505;3311.519829624691;3312.950305745416;3312.950305745416;3313.155145437922;3318.767686261963;4694.366260554815;4694.389729335198;4713.5993440557595;4718.598919091882;4722.150012997659;4186.183694179636;4291.849785257501;4298.656107511423;4341.218580655481;4358.2808836541935;4996.2755400467095;5010.298558201855;5012.616483873371;5040.42035165957;5041.59667226621;3667.963320366789;3676.246369494247;3686.8340924658455;3693.076730817296;3698.223373091654;5089.160288552384;5221.973890130563;5234.293370394986;5246.422893481714;5260.500252476008;3778.981105094457;3779.998300450383;3792.6586607205486;3802.7718336899875;3806.5812760596314;3814.2943555441775;3828.617138286149;3831.233753249361;3836.07934095815;3844.2695887781233;4316.352547117957;4319.179355922364;4319.984803571158;4320.589543993316;4325.3728209409455;4806.375171227788;4921.50784921505;4989.80040798364;5006.249062640561;5026.145555255615;1303.4720938020116;1317.1504379675057;1322.5899971009019;1333.812906513204;1337.25782190885;850.4557083466586;868.3660927522817;883.5052370672444;912.2428384440898;934.9719508414622;4338.457692788402;4354.542773008789;4371.890702732457;4372.491490435795;4375.365571992043;5087.592992560586;5124.590032797368;5134.614903882224;5134.921666450013;5140.845774626767;4229.767362795076;4367.978160109179;4368.803403846835;4371.978140109279;4373.322135069069;2761.4891245119716;2775.3755405033708;2778.055361247135;2789.288731373487;2789.511835428792;4924.4583095859425;4939.851804445872;4943.4809345018975;4950.133726597831;4954.256861470736;5062.82280120194;5335.679859208382;5344.35867695879;5351.464853514617;5374.54316383104;4904.6321525886415;4924.655274130777;4949.529794669501;4950.950490495049;4954.777035033432;5207.3751149862255;5214.608904332114;5222.798756286;5245.606579506629;5261.763220655003;4885.364902562644;5118.41138269089;5122.334096567422;5122.871928201825;5135.38375394955;4915.164422048332;4919.114559379203;4933.77797999098;4935.309056731989;4944.728039957837;3700.3339398908456;3721.7580857244193;3731;3735.8132093395766;3742.7192960527523;5083.262926875656;5232.581393488588;5232.633715639869;5241.633085683966;5250.973745131403;5057.468965758542;5059.822906198413;5074.949250507595;5075.822346217865;5091.6181286402925;5041.470645582161;5044.571211446922;5055.595552355876;5061.898762024665;5071.898562028812;4831.299461578122;4970.390544963923;4982;4982.775775090057;4983.900321993612;4829.261465872213;4922.1541921779335;5067.341245638044;5089.236614507853;5112.412072611697;4923.5814955729165;4943.986482771095;4946.975265123651;4947.975260123676;4980.750962451791 07:58:06 INFO - PROCESS | 14817 | |5;yui.html;611.9694015299235;675.2167485716567;708.2881703887592;708.6173466328183;728.3372131360461;12404.31776252307;13254.7349053019;14662;15106.6978660427;15303.15832629205;14556.854431455682;14730;14852.702945941075;14948.551543453686;14959.700805983874;615.5444970721657;767.2021098058041;776.6116941529235;790.6600161930368;799.8840168175611;791.0586402181415;794.3010151067053;795.312055072364;795.6857041468617;797.4736673795296;816.008549612221;817.207308910359;818.0183779464636;819.9344052475817;820.8276261984961;638.5498223752267;656.622442095792;657.9638119903451;659.2682122843639;810.7000409848364;577.4773829684143;592.2271435776311;596.573449983264;596.8269201931435;597.0566504922256;12304.569340073143;12325.69185770354;12336.938315308456;12378.44297006637;12401.441935112942;11404.600838970679;11902.702432439259;11962.282263064244;12064.577739779153;12232.491596659462;11585;11729.768374320744;11760.17678762487;11823.34971576563;12173.634790956197;4123.567025462313;4126.5667104953845;4135.8966025849295;4198.3702444633245;4215.367694845767;64851.35148648547;65396.67301663509;65897.67051164714;65965;66020.66989665022;9945.353552019096;9957.203423726085;9960.601575937026;10065.194784417228;10082.092611664986;17210.483685489457;17299.56751081233;17314.480565583053;17315.653686926442;17475.47573572795;6330.873382532323;6434.67826608677;6516.152900122954;6625.635590042594;6666.200055993312;3679.411294192916;3704.9629503705155;3706.777593344408;3708.721845861571;3742.3825068863875;2733.4259805440684;2755.931101722473;2768;2784.053421836585;2820.6756223034204;491.80082066762304;492.3599320882838;494.9727764972889;517.0512110277607;520.536722317138;462.82181360176577;467.27105715084576;480.603502110753;486.7712175277614;492.4632150955476;6682;6716.294789047178;6775.830604234933;6787.762428315084;7004.824879378057;404.47822309220777;405.705863249142;426.09242313871255;471.4907899468634;510.38498609175855;3362.4451965425433;3422.760406771502;3438.7420943429343;3614.8192590370377;3659.5608526976935;89103;91965.54017229872;94779.52610236904;95242;96915.51542242385;82933;83889;84397.57801210954;84889.57555212184;87505.1249487497;62988.370116299164;72208.2779172212;72435.27564724286;72532.2746772536;75966;8035.4375193738215;8052.194780521901;8085.878711819445;8133.918660813553;8145.79635509117;38609.03477413087;39447.2110557793;40529.189416210924;41289.58710412977;44500;41580.37629435621;43026.78486607672;43121.568784311756;63351.683241583494;65412.67293663501;11425.542978280775;11578.652640420802;11602.303861768321;11742.941285293518;11907.940460297643;11613.477393517143;12593.559225427067;13263.336833158497;13544.458221671417;14116.45378293304;10850.457477125954;11146.219764616724;11176.664700059011;11496.137789665641;11670.183087184156;10954.397508137128;11863.050955923332;11878.821817672915;12045.33750643723;12341.50633974631;11497.655070347902;11554.42227888619;11807;11837.644870653894;12209.145359824726;9437.716868493957;9836.3606365586;9882.901170988485;9893.307468477138;9980.351277166961;9514.19129374011;9665.453527435577;10164.847527287244;10179.592816287266;10189.74525636865 07:58:06 INFO - PROCESS | 14817 | __end_tp_report 07:58:06 INFO - PROCESS | 14817 | __start_cc_report 07:58:06 INFO - PROCESS | 14817 | _x_x_mozilla_cycle_collect,986 07:58:06 INFO - PROCESS | 14817 | __end_cc_report 07:58:06 INFO - PROCESS | 14817 | __startTimestamp1467989886802__endTimestamp 07:58:06 INFO - PROCESS | 14817 | 07:58:06 INFO - PROCESS | 14817 | ------- Summary: start ------- 07:58:06 INFO - PROCESS | 14817 | Number of tests: 6 07:58:06 INFO - PROCESS | 14817 | 07:58:06 INFO - PROCESS | 14817 | [#0] dojo.html Cycles:165 Average:4689.26 Median:4833.25 stddev:496.80 (10.3%) stddev-sans-first:471.01 07:58:06 INFO - PROCESS | 14817 | Values: 2618.2 2621.6 2647.4 2653.3 2667.3 4605.6 4695.6 4749.9 4750.8 4775.7 4703.3 4709.7 4731.2 4743.5 4789.8 4281.4 4295.9 4364.5 4388.3 4390.6 4417.9 4460.9 4482.4 4501.1 4512.2 4252.6 4282.3 4295.0 4393.4 4440.9 4319.6 4335.8 4340.7 4390.2 4417.3 4327.5 4330.8 4375.1 4387.1 4413.0 4737.1 4755.0 4793.5 4800.2 4811.9 4864.2 4956.5 5037.1 5041.3 5158.9 5128.6 5148.8 5150.1 5151.3 5183.2 4529.5 4769.3 4781.0 4802.3 4820.1 5139.1 5194.1 5214.5 5216.8 5274.2 5021.0 5044.5 5055.2 5068.9 5073.8 4935.3 5024.1 5078.3 5137.8 5144.6 4959.9 4967.9 4981.3 4986.8 5040.2 4929.2 4964.8 4997.7 5011.9 5025.6 4173.1 4210.1 4218.7 4280.0 4315.7 3697.4 3736.8 3766.1 3774.8 3821.2 4354.3 4367.0 4370.6 4402.6 4403.3 4890.3 5136.8 5136.9 5157.1 5181.7 4218.4 4283.9 4324.4 4342.5 4355.3 4552.7 4554.7 4561.3 4563.7 4602.1 4647.1 4825.4 4838.9 4845.0 4853.0 5061.3 5102.4 5114.2 5129.8 5135.7 4795.1 4812.8 4819.5 4840.2 4870.8 4851.5 4940.6 5045.0 5079.6 5126.3 5043.8 5058.0 5077.4 5093.8 5131.1 4912.9 4930.4 4939.5 4956.9 4981.2 4833.3 4840.5 4888.5 4976.9 5003.6 4901.7 4920.2 4933.3 4954.8 4958.7 4987.3 5003.7 5005.9 5008.9 5048.2 4677.4 4794.4 4858.3 4862.1 4890.7 07:58:06 INFO - PROCESS | 14817 | 07:58:06 INFO - PROCESS | 14817 | [#1] ext.html Cycles:180 Average:40243.23 Median:17598.74 stddev:60712.20 (345.0%) stddev-sans-first:60809.34 07:58:06 INFO - PROCESS | 14817 | Values: 545.2 583.2 595.3 604.1 618.7 29831.1 40007.4 40754.8 40872.2 44986.3 41513.4 41634.8 41647.4 41883.2 41904.0 7496.1 7589.3 7592.2 7831.9 7979.9 7543.0 10020.5 10269.3 10276.4 10595.5 10428.2 10469.1 10470.3 10473.9 10507.3 7484.6 7698.8 10014.8 10055.0 10070.5 7701.6 9882.6 10231.5 10253.2 10522.2 39098.8 39449.6 39505.2 39531.2 39637.6 2807.9 2895.4 2933.9 3063.2 3252.0 29282.9 29966.3 30037.4 30037.5 30724.8 3071.3 3095.4 3129.1 3133.7 3172.6 188221.0 188360.0 188531.0 188824.0 189050.0 54528.6 54913.0 55570.4 55603.2 55682.2 57049.7 57060.3 57244.7 57299.6 57309.0 12984.3 13457.3 13463.7 13495.7 13496.5 9490.8 9874.8 9893.2 10129.5 10484.7 17351.7 17489.0 17493.5 17499.3 17517.2 6430.5 6446.8 6487.7 6513.4 6527.0 744.8 765.7 780.1 804.6 827.5 24570.1 25365.4 25693.0 25771.2 25806.4 911.2 935.6 941.3 1017.2 1066.8 13679.2 14167.1 14397.8 14492.8 14539.9 196049.0 196617.0 196854.0 197242.0 198101.0 49960.3 50015.7 50104.5 50144.2 50266.2 1044.5 1050.2 1058.3 1135.6 1204.2 28481.4 29521.6 29894.7 30162.2 30600.0 42469.0 42803.4 43081.4 43196.0 43234.6 296559.0 297255.0 297534.0 297723.0 297944.0 27994.7 28682.6 36539.8 37114.6 37207.4 39797.6 40378.0 40619.2 40711.8 40721.6 35337.0 35553.0 35555.0 35885.3 36084.6 35100.6 35234.6 35551.3 35729.5 36047.1 34690.7 35078.0 35209.5 35340.6 35832.5 31303.8 31651.9 31715.2 31838.7 31945.5 24301.1 24466.0 24719.5 25067.5 25154.9 07:58:06 INFO - PROCESS | 14817 | 07:58:06 INFO - PROCESS | 14817 | [#2] jquery.html Cycles:180 Average:24459.38 Median:19813.07 stddev:63078.78 (318.4%) stddev-sans-first:63229.72 07:58:06 INFO - PROCESS | 14817 | Values: 333.6 373.7 375.5 381.3 388.1 12831.6 16358.3 16498.4 17413.2 18342.2 16441.3 16832.6 17175.7 17341.7 17346.0 4455.2 5048.5 5274.7 5275.5 5278.6 3717.2 5994.2 6295.9 6300.9 6410.4 6105.6 6306.5 6333.3 6353.3 6364.6 6303.1 6309.5 6316.8 6343.0 6351.2 5350.1 5519.2 5615.6 5618.8 5625.2 17487.8 17614.2 18490.0 21490.9 21689.0 1921.7 1962.5 1974.4 1987.8 2002.2 13726.0 13770.7 13827.7 13851.2 13851.5 1729.8 1735.1 1759.6 1789.2 1856.2 67897.3 68205.7 68446.3 69009.7 69718.0 9005.4 9340.3 10102.5 10110.1 10194.4 13605.5 13704.4 13729.9 13738.7 13759.0 7203.0 7205.1 7271.5 7317.9 7356.4 6796.3 6914.9 6946.3 6951.7 7137.5 5461.2 6091.4 6213.8 6260.2 6307.6 1604.7 1648.5 1701.0 1713.9 1722.2 836.5 838.9 839.6 856.7 951.2 16720.9 17317.4 17629.3 17928.5 17974.9 833.1 853.3 859.4 874.7 880.8 9826.4 10174.1 10308.8 10316.9 10465.8 369041.0 384681.0 385334.0 386047.0 386096.0 71447.0 71884.3 72868.3 73007.6 73565.3 824.2 879.9 941.3 942.0 944.5 16008.6 16370.7 16411.9 16630.3 16956.2 38596.4 39238.0 39539.8 40826.4 40927.4 54874.5 55807.0 56342.0 56557.7 57151.7 7729.2 7761.6 7857.0 7875.0 8103.4 8792.4 10513.7 12001.8 12231.0 12249.3 10678.9 10756.1 10775.1 10962.2 11207.0 10387.1 10439.7 10463.1 10706.8 10813.5 10467.8 10540.8 10724.9 11003.6 11044.5 7878.4 7952.2 8016.2 8078.3 8244.7 9780.6 9966.2 10136.1 10145.1 10166.6 07:58:06 INFO - PROCESS | 14817 | 07:58:06 INFO - PROCESS | 14817 | [#3] mootools.html Cycles:180 Average:5164.57 Median:5086.44 stddev:2935.25 (57.7%) stddev-sans-first:2929.48 07:58:06 INFO - PROCESS | 14817 | Values: 1349.8 1394.4 1462.8 1671.7 1703.5 7548.1 8022.1 8075.2 8087.4 8092.4 6799.5 7361.0 7578.0 7586.9 7754.0 2206.2 2236.3 2238.3 2239.2 2245.3 1845.1 2141.2 2165.6 2194.9 2226.6 2177.9 2209.1 2216.4 2216.8 2225.6 2178.9 2187.4 2204.3 2217.6 2219.6 2145.8 2148.9 2152.9 2159.8 2189.9 7955.6 8028.1 8031.0 8052.2 8055.4 4554.4 4568.9 4630.5 4636.4 4715.8 2717.4 2808.4 2828.8 2851.9 2860.3 868.6 899.5 903.3 905.8 908.3 10686.6 10691.8 10718.4 10719.1 10723.4 4004.3 4172.1 4348.4 4350.7 4359.2 9200.7 9218.9 9219.2 9225.0 9225.2 4718.6 4731.0 4740.5 4749.2 4757.8 4248.2 4307.4 4316.0 4320.4 4320.9 3631.1 3668.9 3708.4 3730.7 3776.2 1089.3 1180.8 1183.6 1197.9 1205.9 716.8 738.8 748.1 755.7 787.5 4960.4 5012.4 5028.1 5064.2 5092.6 816.3 845.0 848.2 855.5 929.6 3331.9 3364.7 3369.1 3421.5 3458.3 9522.0 9855.0 9949.6 9950.0 9966.2 9786.9 9841.7 9842.2 9854.8 9868.6 6785.9 7105.5 7131.5 7229.4 7243.7 5078.8 5080.3 5293.8 5336.8 5351.0 8749.0 9056.5 9170.4 9195.3 9195.5 9077.1 9148.8 9231.5 9411.8 9415.3 6596.2 6920.2 6942.1 7031.8 7092.2 7584.4 7595.8 7629.5 7645.2 7651.3 6565.9 6755.0 6850.7 6874.3 6936.8 6818.9 6835.1 6890.1 7025.3 7090.3 6192.6 6256.0 6306.8 6310.9 6311.1 4237.4 4279.7 4314.8 4329.2 4353.4 4388.2 4438.7 4446.6 4473.1 4480.1 07:58:06 INFO - PROCESS | 14817 | 07:58:06 INFO - PROCESS | 14817 | [#4] prototype.html Cycles:180 Average:4202.38 Median:4803.85 stddev:1204.17 (25.1%) stddev-sans-first:1171.49 07:58:06 INFO - PROCESS | 14817 | Values: 305.4 306.7 308.0 308.1 310.9 4795.7 4801.3 4811.4 4813.1 4815.1 4762.5 4781.2 4789.5 4794.3 4817.8 3603.8 3688.9 3752.9 3806.7 3837.6 3760.0 3822.9 3845.5 3846.4 3862.7 3783.8 3788.6 3790.5 3802.5 3807.9 3616.9 3633.9 3733.5 3755.5 3759.1 3311.5 3313.0 3313.0 3313.2 3318.8 4694.4 4694.4 4713.6 4718.6 4722.2 4186.2 4291.8 4298.7 4341.2 4358.3 4996.3 5010.3 5012.6 5040.4 5041.6 3668.0 3676.2 3686.8 3693.1 3698.2 5089.2 5222.0 5234.3 5246.4 5260.5 3779.0 3780.0 3792.7 3802.8 3806.6 3814.3 3828.6 3831.2 3836.1 3844.3 4316.4 4319.2 4320.0 4320.6 4325.4 4806.4 4921.5 4989.8 5006.2 5026.1 1303.5 1317.2 1322.6 1333.8 1337.3 850.5 868.4 883.5 912.2 935.0 4338.5 4354.5 4371.9 4372.5 4375.4 5087.6 5124.6 5134.6 5134.9 5140.8 4229.8 4368.0 4368.8 4372.0 4373.3 2761.5 2775.4 2778.1 2789.3 2789.5 4924.5 4939.9 4943.5 4950.1 4954.3 5062.8 5335.7 5344.4 5351.5 5374.5 4904.6 4924.7 4949.5 4951.0 4954.8 5207.4 5214.6 5222.8 5245.6 5261.8 4885.4 5118.4 5122.3 5122.9 5135.4 4915.2 4919.1 4933.8 4935.3 4944.7 3700.3 3721.8 3731.0 3735.8 3742.7 5083.3 5232.6 5232.6 5241.6 5251.0 5057.5 5059.8 5074.9 5075.8 5091.6 5041.5 5044.6 5055.6 5061.9 5071.9 4831.3 4970.4 4982.0 4982.8 4983.9 4829.3 4922.2 5067.3 5089.2 5112.4 4923.6 4944.0 4947.0 4948.0 4980.8 07:58:06 INFO - PROCESS | 14817 | 07:58:06 INFO - PROCESS | 14817 | [#5] yui.html Cycles:180 Average:17230.30 Median:22481.41 stddev:24479.30 (108.9%) stddev-sans-first:24516.17 07:58:06 INFO - PROCESS | 14817 | Values: 612.0 675.2 708.3 708.6 728.3 12404.3 13254.7 14662.0 15106.7 15303.2 14556.9 14730.0 14852.7 14948.6 14959.7 615.5 767.2 776.6 790.7 799.9 791.1 794.3 795.3 795.7 797.5 816.0 817.2 818.0 819.9 820.8 638.5 656.6 658.0 659.3 810.7 577.5 592.2 596.6 596.8 597.1 12304.6 12325.7 12336.9 12378.4 12401.4 11404.6 11902.7 11962.3 12064.6 12232.5 11585.0 11729.8 11760.2 11823.3 12173.6 4123.6 4126.6 4135.9 4198.4 4215.4 64851.4 65396.7 65897.7 65965.0 66020.7 9945.4 9957.2 9960.6 10065.2 10082.1 17210.5 17299.6 17314.5 17315.7 17475.5 6330.9 6434.7 6516.2 6625.6 6666.2 3679.4 3705.0 3706.8 3708.7 3742.4 2733.4 2755.9 2768.0 2784.1 2820.7 491.8 492.4 495.0 517.1 520.5 462.8 467.3 480.6 486.8 492.5 6682.0 6716.3 6775.8 6787.8 7004.8 404.5 405.7 426.1 471.5 510.4 3362.4 3422.8 3438.7 3614.8 3659.6 89103.0 91965.5 94779.5 95242.0 96915.5 82933.0 83889.0 84397.6 84889.6 87505.1 62988.4 72208.3 72435.3 72532.3 75966.0 8035.4 8052.2 8085.9 8133.9 8145.8 38609.0 39447.2 40529.2 41289.6 44500.0 41580.4 43026.8 43121.6 63351.7 65412.7 11425.5 11578.7 11602.3 11742.9 11907.9 11613.5 12593.6 13263.3 13544.5 14116.5 10850.5 11146.2 11176.7 11496.1 11670.2 10954.4 11863.1 11878.8 12045.3 12341.5 11497.7 11554.4 11807.0 11837.6 12209.1 9437.7 9836.4 9882.9 9893.3 9980.4 9514.2 9665.5 10164.8 10179.6 10189.7 07:58:06 INFO - PROCESS | 14817 | -------- Summary: end -------- 07:58:06 INFO - PROCESS | 14817 | 07:58:07 INFO - TEST-INFO | 14817: exit 0 07:58:07 INFO - TEST-OK | dromaeo_css | took 1119827ms 07:58:07 INFO - TEST-START | kraken 07:58:07 INFO - operating with platform_type : linux_ 07:58:07 INFO - Initialising browser for kraken test... 07:58:07 INFO - TEST-INFO | started process 15005 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsUW2pg/profile http://localhost:48303/getInfo.html) 07:58:11 INFO - PROCESS | 15005 | __metrics Screen width/height:1600/1200 07:58:11 INFO - PROCESS | 15005 | colorDepth:24 07:58:11 INFO - PROCESS | 15005 | Browser inner width/height: 1024/697 07:58:11 INFO - PROCESS | 15005 | __metrics 07:58:13 INFO - PROCESS | 15005 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:58:14 INFO - TEST-INFO | 15005: exit 0 07:58:14 INFO - Browser initialized. 07:58:14 INFO - Running cycle 1/1 for kraken test... 07:58:14 INFO - TEST-INFO | started process 15087 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsUW2pg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:58:26 INFO - PROCESS | 15087 | RSS: Main: 158855168 07:58:26 INFO - PROCESS | 15087 | 07:58:28 INFO - PROCESS | 15087 | Cycle 1(1): loaded http://localhost:48303/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48303/tests/kraken/driver.html?testName=audio-beat-detection) 07:58:29 INFO - PROCESS | 15087 | RSS: Main: 216944640 07:58:29 INFO - PROCESS | 15087 | 07:58:32 INFO - PROCESS | 15087 | Cycle 1(1): loaded http://localhost:48303/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48303/tests/kraken/driver.html?testName=audio-dft) 07:58:33 INFO - PROCESS | 15087 | RSS: Main: 203620352 07:58:33 INFO - PROCESS | 15087 | 07:58:36 INFO - PROCESS | 15087 | Cycle 1(1): loaded http://localhost:48303/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48303/tests/kraken/driver.html?testName=audio-fft) 07:58:36 INFO - PROCESS | 15087 | RSS: Main: 271577088 07:58:36 INFO - PROCESS | 15087 | 07:58:39 INFO - PROCESS | 15087 | Cycle 1(1): loaded http://localhost:48303/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48303/tests/kraken/driver.html?testName=audio-oscillator) 07:58:39 INFO - PROCESS | 15087 | RSS: Main: 182124544 07:58:39 INFO - PROCESS | 15087 | 07:58:41 INFO - PROCESS | 15087 | Cycle 1(1): loaded http://localhost:48303/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48303/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:58:42 INFO - PROCESS | 15087 | RSS: Main: 185184256 07:58:42 INFO - PROCESS | 15087 | 07:58:45 INFO - PROCESS | 15087 | Cycle 1(1): loaded http://localhost:48303/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48303/tests/kraken/driver.html?testName=imaging-darkroom) 07:58:46 INFO - PROCESS | 15087 | RSS: Main: 221474816 07:58:46 INFO - PROCESS | 15087 | 07:58:49 INFO - PROCESS | 15087 | Cycle 1(1): loaded http://localhost:48303/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48303/tests/kraken/driver.html?testName=imaging-desaturate) 07:58:50 INFO - PROCESS | 15087 | RSS: Main: 217067520 07:58:50 INFO - PROCESS | 15087 | 07:58:53 INFO - PROCESS | 15087 | Cycle 1(1): loaded http://localhost:48303/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48303/tests/kraken/driver.html?testName=json-parse-financial) 07:58:54 INFO - PROCESS | 15087 | RSS: Main: 220442624 07:58:54 INFO - PROCESS | 15087 | 07:58:55 INFO - PROCESS | 15087 | Cycle 1(1): loaded http://localhost:48303/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48303/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:58:56 INFO - PROCESS | 15087 | RSS: Main: 204120064 07:58:56 INFO - PROCESS | 15087 | 07:58:58 INFO - PROCESS | 15087 | Cycle 1(1): loaded http://localhost:48303/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48303/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:58:58 INFO - PROCESS | 15087 | RSS: Main: 207781888 07:58:58 INFO - PROCESS | 15087 | 07:59:00 INFO - PROCESS | 15087 | Cycle 1(1): loaded http://localhost:48303/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48303/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:59:01 INFO - PROCESS | 15087 | RSS: Main: 211677184 07:59:01 INFO - PROCESS | 15087 | 07:59:04 INFO - PROCESS | 15087 | Cycle 1(1): loaded http://localhost:48303/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48303/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:59:05 INFO - PROCESS | 15087 | RSS: Main: 225177600 07:59:05 INFO - PROCESS | 15087 | 07:59:07 INFO - PROCESS | 15087 | Cycle 1(1): loaded http://localhost:48303/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48303/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:59:08 INFO - PROCESS | 15087 | RSS: Main: 226398208 07:59:08 INFO - PROCESS | 15087 | 07:59:10 INFO - PROCESS | 15087 | Cycle 1(1): loaded http://localhost:48303/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48303/tests/kraken/driver.html?testName=ai-astar) 07:59:10 INFO - PROCESS | 15087 | RSS: Main: 268808192 07:59:10 INFO - PROCESS | 15087 | 07:59:10 INFO - PROCESS | 15087 | __start_tp_report 07:59:10 INFO - PROCESS | 15087 | _x_x_mozilla_page_load 07:59:10 INFO - PROCESS | 15087 | _x_x_mozilla_page_load_details 07:59:10 INFO - PROCESS | 15087 | |i|pagename|runs| 07:59:10 INFO - PROCESS | 15087 | |0;ai-astar;110;114;114;113;114;114;112;113;113;113 07:59:10 INFO - PROCESS | 15087 | |1;audio-beat-detection;157;126;128;193;133;127;149;128;166;126 07:59:10 INFO - PROCESS | 15087 | |2;audio-dft;163;161;163;163;163;163;162;163;163;163 07:59:10 INFO - PROCESS | 15087 | |3;audio-fft;76;78;89;124;77;76;76;77;118;78 07:59:10 INFO - PROCESS | 15087 | |4;audio-oscillator;84;85;117;86;87;86;124;86;86;141 07:59:10 INFO - PROCESS | 15087 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;116;117 07:59:10 INFO - PROCESS | 15087 | |6;imaging-darkroom;148;147;146;147;147;148;147;147;147;147 07:59:10 INFO - PROCESS | 15087 | |7;imaging-desaturate;95;95;95;95;94;96;95;95;94;94 07:59:10 INFO - PROCESS | 15087 | |8;json-parse-financial;62;61;62;62;62;62;62;62;61;62 07:59:10 INFO - PROCESS | 15087 | |9;json-stringify-tinderbox;64;64;64;63;65;64;64;64;65;64 07:59:10 INFO - PROCESS | 15087 | |10;stanford-crypto-aes;81;81;80;81;80;79;83;80;80;79 07:59:10 INFO - PROCESS | 15087 | |11;stanford-crypto-ccm;129;131;131;128;129;133;145;134;174;139 07:59:10 INFO - PROCESS | 15087 | |12;stanford-crypto-pbkdf2;166;168;170;167;172;168;169;167;169;167 07:59:10 INFO - PROCESS | 15087 | |13;stanford-crypto-sha256-iterative;68;69;70;68;68;68;68;69;69;68 07:59:10 INFO - PROCESS | 15087 | __end_tp_report 07:59:10 INFO - PROCESS | 15087 | __start_cc_report 07:59:10 INFO - PROCESS | 15087 | _x_x_mozilla_cycle_collect,1927 07:59:10 INFO - PROCESS | 15087 | __end_cc_report 07:59:10 INFO - PROCESS | 15087 | __startTimestamp1467989950568__endTimestamp 07:59:10 INFO - PROCESS | 15087 | 07:59:10 INFO - PROCESS | 15087 | ------- Summary: start ------- 07:59:10 INFO - PROCESS | 15087 | Number of tests: 14 07:59:10 INFO - PROCESS | 15087 | 07:59:10 INFO - PROCESS | 15087 | [#0] ai-astar Cycles:10 Average:113.00 Median:113.50 stddev:1.25 (1.1%) stddev-sans-first:0.71 07:59:10 INFO - PROCESS | 15087 | Values: 110.0 114.0 114.0 113.0 114.0 114.0 112.0 113.0 113.0 113.0 07:59:10 INFO - PROCESS | 15087 | 07:59:10 INFO - PROCESS | 15087 | [#1] audio-beat-detection Cycles:10 Average:143.30 Median:141.00 stddev:22.72 (16.1%) stddev-sans-first:23.55 07:59:10 INFO - PROCESS | 15087 | Values: 157.0 126.0 128.0 193.0 133.0 127.0 149.0 128.0 166.0 126.0 07:59:10 INFO - PROCESS | 15087 | 07:59:10 INFO - PROCESS | 15087 | [#2] audio-dft Cycles:10 Average:162.70 Median:163.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 07:59:10 INFO - PROCESS | 15087 | Values: 163.0 161.0 163.0 163.0 163.0 163.0 162.0 163.0 163.0 163.0 07:59:10 INFO - PROCESS | 15087 | 07:59:10 INFO - PROCESS | 15087 | [#3] audio-fft Cycles:10 Average:86.90 Median:77.00 stddev:18.44 (23.9%) stddev-sans-first:19.13 07:59:10 INFO - PROCESS | 15087 | Values: 76.0 78.0 89.0 124.0 77.0 76.0 76.0 77.0 118.0 78.0 07:59:10 INFO - PROCESS | 15087 | 07:59:10 INFO - PROCESS | 15087 | [#4] audio-oscillator Cycles:10 Average:98.20 Median:86.00 stddev:20.94 (24.4%) stddev-sans-first:21.57 07:59:10 INFO - PROCESS | 15087 | Values: 84.0 85.0 117.0 86.0 87.0 86.0 124.0 86.0 86.0 141.0 07:59:10 INFO - PROCESS | 15087 | 07:59:10 INFO - PROCESS | 15087 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 07:59:10 INFO - PROCESS | 15087 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 07:59:10 INFO - PROCESS | 15087 | 07:59:10 INFO - PROCESS | 15087 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 07:59:10 INFO - PROCESS | 15087 | Values: 148.0 147.0 146.0 147.0 147.0 148.0 147.0 147.0 147.0 147.0 07:59:10 INFO - PROCESS | 15087 | 07:59:10 INFO - PROCESS | 15087 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 07:59:10 INFO - PROCESS | 15087 | Values: 95.0 95.0 95.0 95.0 94.0 96.0 95.0 95.0 94.0 94.0 07:59:10 INFO - PROCESS | 15087 | 07:59:10 INFO - PROCESS | 15087 | [#8] json-parse-financial Cycles:10 Average:61.80 Median:62.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 07:59:10 INFO - PROCESS | 15087 | Values: 62.0 61.0 62.0 62.0 62.0 62.0 62.0 62.0 61.0 62.0 07:59:10 INFO - PROCESS | 15087 | 07:59:10 INFO - PROCESS | 15087 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 07:59:10 INFO - PROCESS | 15087 | Values: 64.0 64.0 64.0 63.0 65.0 64.0 64.0 64.0 65.0 64.0 07:59:10 INFO - PROCESS | 15087 | 07:59:10 INFO - PROCESS | 15087 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:80.50 stddev:1.17 (1.5%) stddev-sans-first:1.22 07:59:10 INFO - PROCESS | 15087 | Values: 81.0 81.0 80.0 81.0 80.0 79.0 83.0 80.0 80.0 79.0 07:59:10 INFO - PROCESS | 15087 | 07:59:10 INFO - PROCESS | 15087 | [#11] stanford-crypto-ccm Cycles:10 Average:137.30 Median:133.50 stddev:13.91 (10.4%) stddev-sans-first:14.43 07:59:10 INFO - PROCESS | 15087 | Values: 129.0 131.0 131.0 128.0 129.0 133.0 145.0 134.0 174.0 139.0 07:59:10 INFO - PROCESS | 15087 | 07:59:10 INFO - PROCESS | 15087 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.30 Median:168.50 stddev:1.77 (1.0%) stddev-sans-first:1.67 07:59:10 INFO - PROCESS | 15087 | Values: 166.0 168.0 170.0 167.0 172.0 168.0 169.0 167.0 169.0 167.0 07:59:10 INFO - PROCESS | 15087 | 07:59:10 INFO - PROCESS | 15087 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.50 stddev:0.71 (1.0%) stddev-sans-first:0.73 07:59:10 INFO - PROCESS | 15087 | Values: 68.0 69.0 70.0 68.0 68.0 68.0 68.0 69.0 69.0 68.0 07:59:10 INFO - PROCESS | 15087 | -------- Summary: end -------- 07:59:10 INFO - PROCESS | 15087 | 07:59:11 INFO - TEST-INFO | 15087: exit 0 07:59:11 INFO - TEST-OK | kraken | took 63911ms 07:59:11 INFO - SUITE-END | took 1183s 07:59:11 INFO - Completed test suite (00:19:43) 07:59:11 INFO - javascript benchmark 07:59:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2618.2276228512587, 2621.5936529837873, 2647.3646324882034, 2653.296876327772, 2667.3065003099186, 4605.608523275526, 4695.6478264130155, 4749.8812529686775, 4750.833720819768, 4775.689580177291, 4703.3180188872675, 4709.717416954976, 4731.1956967315555, 4743.4545027321865, 4789.832355867546, 4281.422008028923, 4295.935560966573, 4364.498082720496, 4388.253996820532, 4390.626796722267, 4417.867463976086, 4460.910781784362, 4482.417285752847, 4501.054778496519, 4512.16524942885, 4252.596003379674, 4282.314829627276, 4295.0, 4393.406890069831, 4440.911181776346, 4319.611234988866, 4335.761533115678, 4340.739555626673, 4390.1878152541885, 4417.293233082723, 4327.502337231227, 4330.826766929351, 4375.1031038637, 4387.122575484916, 4413.029133590605, 4737.147313483571, 4754.976225118887, 4793.520647935214, 4800.207965685692, 4811.855644330676, 4864.173090574611, 4956.4547899731, 5037.143685573461, 5041.344625198737, 5158.92261616076, 5128.5640720538795, 5148.768305426265, 5150.098732721796, 5151.330327057496, 5183.222516622499, 4529.479109902403, 4769.260764581495, 4781.019890922353, 4802.27965805125, 4820.132376172288, 5139.12634852076, 5194.1429664105, 5214.452482489284, 5216.765245563959, 5274.156135018378, 5021.046001259749, 5044.520770526794, 5055.241713742968, 5068.949310506848, 5073.7716802743225, 4935.284383764334, 5024.145895197825, 5078.314427552307, 5137.845864624067, 5144.639875208774, 4959.925601115986, 4967.90064198714, 4981.277714731416, 4986.800527978913, 5040.168372218616, 4929.2359684248995, 4964.801407943714, 4997.7251251180805, 5011.949880501148, 5025.623078269145, 4173.10278290163, 4210.073783767566, 4218.704690671623, 4279.957200428018, 4315.741055536615, 3697.352963231424, 3736.75711078779, 3766.114962983697, 3774.7735135891385, 3821.2357528494413, 4354.325079612665, 4367.039251364695, 4370.606645401929, 4402.625776808943, 4403.2734598791485, 4890.315355850184, 5136.794528218904, 5136.922946155811, 5157.149070403417, 5181.715005674724, 4218.409422680827, 4283.929017745563, 4324.372965919924, 4342.457192850894, 4355.259605867011, 4552.681312308173, 4554.681172317906, 4561.29299958507, 4563.680542362069, 4602.125596136723, 4647.117047760915, 4825.420949486084, 4838.854834354905, 4844.975775121102, 4853.02939412119, 5061.291419201389, 5102.36220472441, 5114.181730923035, 5129.820456284012, 5135.743212839268, 4795.088933102699, 4812.807487700453, 4819.469858315512, 4840.177169881058, 4870.756462176948, 4851.51484851512, 4940.629452790983, 5044.974775126101, 5079.568236699774, 5126.307948426915, 5043.773030213576, 5057.974710126426, 5077.365329333833, 5093.821716239914, 5131.127708289674, 4912.901741965212, 4930.359053323045, 4939.53074457926, 4956.925646115239, 4981.153203955264, 4833.250846118857, 4840.491748366511, 4888.535589119028, 4976.850694479172, 5003.574696150722, 4901.705897646153, 4920.188168952226, 4933.309336692938, 4954.777035033504, 4958.727270000185, 4987.326710893983, 5003.724795136302, 5005.923726398842, 5008.899822003613, 5048.192289233852, 4677.438707355139, 4794.400699912511, 4858.319835223142, 4862.07620552094, 4890.657653964188], "value": 4657.304365411222, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.1814489958648, 583.2097507876827, 595.2559300873908, 604.0637012630425, 618.7308520793458, 29831.105066848002, 40007.39988900165, 40754.7962260189, 40872.18255634885, 44986.325205121866, 41513.37729934054, 41634.791826040906, 41647.375289370684, 41883.162336753325, 41904.0, 7496.100467943855, 7589.316961473466, 7592.164861865191, 7831.882521762164, 7979.920200798005, 7543.0, 10020.498975051254, 10269.28115031948, 10276.383416995004, 10595.470226488645, 10428.217883658755, 10469.11012563933, 10470.319429237114, 10473.947630261839, 10507.2644914856, 7484.625768711597, 7698.846023079563, 10014.849777253346, 10055.0, 10070.496475176213, 7701.576413297266, 9882.55528501212, 10231.488425578691, 10253.231007674454, 10522.210834187466, 39098.804505977285, 39449.60550394488, 39505.20989580221, 39531.209375812614, 39637.61268355593, 2807.887684492618, 2895.420915816845, 2933.897313594014, 3063.1576316512915, 3251.9674803252137, 29282.925292844157, 29966.250843728863, 30037.399252015057, 30037.4636046547, 30724.8463757682, 3071.279400696792, 3095.3809238152458, 3129.0769223079246, 3133.6552979172275, 3172.587563616738, 188221.0, 188360.0, 188531.0, 188824.0, 189049.99999999863, 54528.636784080714, 54913.0, 55570.44429555733, 55603.16595250994, 55682.16476752852, 57049.71475142598, 57060.291081080424, 57244.71377643085, 57299.567510812565, 57309.0, 12984.285864277555, 13457.25985070811, 13463.730725385438, 13495.662608434868, 13496.460141594423, 9490.810183796286, 9874.80250394988, 9893.159081478156, 10129.544170512198, 10484.737881553023, 17351.65296694059, 17489.0, 17493.475195744148, 17499.300027998994, 17517.211725472385, 6430.549861509743, 6446.8388290293115, 6487.7080531376205, 6513.446357059703, 6527.0, 744.8361360500681, 765.6784150656738, 780.1184661332771, 804.5574933786394, 827.5324441690426, 24570.140045098335, 25365.365865853502, 25693.0, 25771.226863194133, 25806.354841129123, 911.2391153386864, 935.6444551070549, 941.2799208605422, 1017.1811691588194, 1066.7973085113804, 13679.24764137982, 14167.128932561953, 14397.78403323951, 14492.782608260884, 14539.92730036343, 196049.0, 196617.0, 196854.0, 197242.0, 198101.0, 49960.25059624109, 50015.749921250164, 50104.498955009985, 50144.247836282484, 50266.246006309935, 1044.4673216659558, 1050.175612144463, 1058.2909450668226, 1135.6082151657665, 1204.175140029083, 28481.43037139287, 29521.557176642797, 29894.70105299006, 30162.24594385158, 30600.0, 42469.0, 42803.357949631405, 43081.353779692705, 43196.0, 43234.56765432305, 296559.0, 297255.0, 297534.0, 297723.0, 297944.0, 27994.72005279921, 28682.56976145401, 36539.817300913324, 37114.62885371112, 37207.441888371155, 39797.60202397939, 40378.0, 40619.18761624692, 40711.79644101761, 40721.592784072964, 35337.0, 35553.0, 35555.0, 35885.28229435449, 36084.63915360813, 35100.64899350974, 35234.59567554056, 35551.288974220886, 35729.46405803863, 36047.098822529646, 34690.65309346975, 35078.0, 35209.47185792164, 35340.64659353373, 35832.46251306285, 31303.84348078245, 31651.863414439493, 31715.20711982219, 31838.681613184497, 31945.520817187295, 24301.14945976882, 24466.0, 24719.50560988806, 25067.493250674786, 25154.874225628755], "value": 17287.776442330825, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.55970119442344, 373.689837434929, 375.45558939537676, 381.31744177921524, 388.1402693034927, 12831.55089571864, 16358.263878125483, 16498.42255521057, 17413.216405261763, 18342.174602142903, 16441.26014329355, 16832.55927890455, 17175.742363864552, 17341.653166936685, 17346.0, 4455.175792478386, 5048.495150484959, 5274.683518988853, 5275.525202731754, 5278.577713782888, 3717.1636381814146, 5994.220751302325, 6295.937040629581, 6300.905486417684, 6410.423061924426, 6105.633661980273, 6306.495480361583, 6333.303336632966, 6353.2693740219775, 6364.618122912617, 6303.086052522382, 6309.526785491106, 6316.778912738032, 6342.999999999977, 6351.237851457809, 5350.0904846176245, 5519.227308176858, 5615.550755939515, 5618.8314350569135, 5625.156226566048, 17487.825121748872, 17614.2073606688, 18490.0, 21490.89254553733, 21689.0, 1921.7213504041974, 1962.460323411059, 1974.3978086683555, 1987.791281915407, 2002.1991203518564, 13726.0, 13770.65573360664, 13827.723445531134, 13851.16892986424, 13851.515196968057, 1729.8183690712547, 1735.0977491704243, 1759.6304775996928, 1789.2127463915836, 1856.2296646891523, 67897.32102679009, 68205.65897170482, 68446.31553684449, 69009.65495172542, 69718.0, 9005.414648047856, 9340.252779777602, 10102.494875256209, 10110.140638045701, 10194.388336699822, 13605.523806666719, 13704.383302751201, 13729.931350343184, 13738.725225495435, 13759.0, 7202.96398518004, 7205.099362579677, 7271.454640901953, 7317.926820731831, 7356.37470814976, 6796.320367963263, 6914.896276555855, 6946.340097690812, 6951.65241737911, 7137.536060156073, 5461.208124821878, 6091.365565538996, 6213.844653883599, 6260.186175797208, 6307.5584709070845, 1604.6710424362977, 1648.4642491190411, 1700.9574760631083, 1713.9400120995706, 1722.1647500962024, 836.5190015740851, 838.9035260945069, 839.6221700234919, 856.6873091321622, 951.1629765806184, 16720.916395417946, 17317.393891213746, 17629.294828206726, 17928.462146135636, 17974.91012544929, 833.1127349372898, 853.2661910756744, 859.3984211052289, 874.6851133591902, 880.823835232956, 9826.4104153751, 10174.13519850821, 10308.793824123475, 10316.948415257875, 10465.84301235482, 369041.0, 384681.0, 385334.0, 386047.0, 386096.0, 71447.0, 71884.2811571888, 72868.2713172872, 73007.63496182485, 73565.26434735692, 824.2046425199711, 879.9032106468284, 941.261110028638, 942.0297093993198, 944.4616568555995, 16008.599785005003, 16370.67258654844, 16411.91794041022, 16630.25163867653, 16956.23696933616, 38596.421053683654, 39237.99999999886, 39539.80230098831, 40826.38760418655, 40927.38608920928, 54874.451255486936, 55807.0, 56342.0, 56557.71721141368, 57151.714241428526, 7729.1884352142215, 7761.611919403895, 7856.960715196387, 7874.960625196837, 8103.392245581487, 8792.384533082623, 10513.684589462327, 12001.81997270059, 12231.0, 12249.265044097383, 10678.8932110681, 10756.139508839431, 10775.137988961022, 10962.232643714864, 11207.0, 10387.117095047006, 10439.739006524898, 10463.110635595755, 10706.839397408889, 10813.513391897226, 10467.790644187226, 10540.841887371542, 10724.946375268073, 11003.559857605926, 11044.502997364978, 7878.4091193161885, 7952.204779522233, 8016.198380161937, 8078.313343365645, 8244.670213191404, 9780.559874805509, 9966.202703783534, 10136.138428233682, 10145.137663298703, 10166.644167454104], "value": 8521.716430249277, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1349.8447678516973, 1394.4004078246355, 1462.7513322735133, 1671.6573102513985, 1703.4889533140047, 7548.094228692551, 8022.117567067632, 8075.192480751929, 8087.3934454915825, 8092.352611791065, 6799.4560435165195, 7360.9631951840165, 7577.962110189442, 7586.886196707053, 7754.030746156731, 2206.249875042485, 2236.317923033474, 2238.328501449567, 2239.2498512998163, 2245.315178870444, 1845.1235663060074, 2141.2077531313435, 2165.6426689596196, 2194.9451263718374, 2226.6214743493565, 2177.912883484659, 2209.0942713487475, 2216.423729830248, 2216.8226541876693, 2225.5660146271484, 2178.880161591112, 2187.3984654220058, 2204.2946257197705, 2217.5897458970144, 2219.6448568229166, 2145.8068773810433, 2148.871067735941, 2152.860064095829, 2159.75162856272, 2189.9452513687124, 7955.562444065574, 8028.11690714021, 8030.959845200795, 8052.154523775036, 8055.3958453115665, 4554.362389265505, 4568.88577785558, 4630.490646028934, 4636.420447444069, 4715.7877895494785, 2717.429339838636, 2808.3540785619216, 2828.7595554377904, 2851.9429611407863, 2860.284928767808, 868.6004437958546, 899.4872922434215, 903.2773780975193, 905.8233644439337, 908.3414524469773, 10686.572537098507, 10691.78616427675, 10718.35689858611, 10719.142468602493, 10723.410212438313, 4004.3392840181045, 4172.123853990635, 4348.391225228471, 4350.695451318441, 4359.237133501624, 9200.723978280663, 9218.86171707425, 9219.21636660878, 9225.0, 9225.215856652125, 4718.598919091915, 4730.95269047312, 4740.502247264057, 4749.1926372516755, 4757.762111894392, 4248.192843359813, 4307.375430562551, 4315.978420107942, 4320.373545835836, 4320.891977700519, 3631.128529153037, 3668.944965825515, 3708.38811596089, 3730.6828919542145, 3776.2069965307046, 1089.2701889733896, 1180.8228765685044, 1183.627157445402, 1197.868234494205, 1205.9397030148457, 716.8136284565946, 738.800523858566, 748.0761259844088, 755.7279379423403, 787.5314188058096, 4960.355153829979, 5012.373453318335, 5028.069807085701, 5064.240363945438, 5092.618053645917, 816.2898278497745, 844.966201351939, 848.1687945813138, 855.4985999570714, 929.6420877961898, 3331.93336133276, 3364.747643926715, 3369.107186595554, 3421.5380923575494, 3458.291050334675, 9522.0, 9854.950725246328, 9949.602015919281, 9950.009998000429, 9966.15287700539, 9786.902130978742, 9841.655542056136, 9842.163416109568, 9854.753631159278, 9868.605255789687, 6785.898211526831, 7105.502614816914, 7131.536450130621, 7229.385502232264, 7243.674034668347, 5078.822241221539, 5080.26336181259, 5293.761780719799, 5336.839894803162, 5350.9732451337495, 8749.0, 9056.501892395981, 9170.403923744936, 9195.310351723781, 9195.54022298869, 9077.137671921157, 9148.771280718036, 9231.538423078953, 9411.811763764823, 9415.340926135104, 6596.175478065242, 6920.204176519765, 6942.132233470817, 7031.7890463286185, 7092.184398794205, 7584.355329797029, 7595.810104747426, 7629.504082234637, 7645.159032506309, 7651.3496352810635, 6565.934340656532, 6755.0, 6850.6574671267235, 6874.346937040973, 6936.757213497705, 6818.8636227276165, 6835.111435513351, 6890.138732658418, 7025.332593403618, 7090.255523169993, 6192.628442293477, 6256.0, 6306.842328941813, 6310.873782524232, 6311.116443697978, 4237.406763053236, 4279.700420970502, 4314.827406903689, 4329.15581461612, 4353.368761529624, 4388.2320593896575, 4438.733675979452, 4446.599806017474, 4473.105378924293, 4480.126375356775], "value": 4132.683626408505, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.4364697133788, 306.7132231363674, 308.03584779639726, 308.08345173109996, 310.9207152176198, 4795.68828026178, 4801.327814106019, 4811.374521312233, 4813.109574728677, 4815.109204797115, 4762.476127625959, 4781.16329642312, 4789.5210478952085, 4794.256890182019, 4817.783199756011, 3603.8466341950793, 3688.926221475582, 3752.9437058444146, 3806.71449641278, 3837.5970523095093, 3759.9812000939955, 3822.8661996830115, 3845.4616353710503, 3846.3653497173073, 3862.7059934921836, 3783.772973621578, 3788.602196769341, 3790.4503846942175, 3802.505674262342, 3807.9048023799487, 3616.8553257869785, 3633.927321453556, 3733.4586484959527, 3755.511783468159, 3759.1353988582505, 3311.519829624691, 3312.950305745416, 3312.950305745416, 3313.155145437922, 3318.767686261963, 4694.366260554815, 4694.389729335198, 4713.5993440557595, 4718.598919091882, 4722.150012997659, 4186.183694179636, 4291.849785257501, 4298.656107511423, 4341.218580655481, 4358.2808836541935, 4996.2755400467095, 5010.298558201855, 5012.616483873371, 5040.42035165957, 5041.59667226621, 3667.963320366789, 3676.246369494247, 3686.8340924658455, 3693.076730817296, 3698.223373091654, 5089.160288552384, 5221.973890130563, 5234.293370394986, 5246.422893481714, 5260.500252476008, 3778.981105094457, 3779.998300450383, 3792.6586607205486, 3802.7718336899875, 3806.5812760596314, 3814.2943555441775, 3828.617138286149, 3831.233753249361, 3836.07934095815, 3844.2695887781233, 4316.352547117957, 4319.179355922364, 4319.984803571158, 4320.589543993316, 4325.3728209409455, 4806.375171227788, 4921.50784921505, 4989.80040798364, 5006.249062640561, 5026.145555255615, 1303.4720938020116, 1317.1504379675057, 1322.5899971009019, 1333.812906513204, 1337.25782190885, 850.4557083466586, 868.3660927522817, 883.5052370672444, 912.2428384440898, 934.9719508414622, 4338.457692788402, 4354.542773008789, 4371.890702732457, 4372.491490435795, 4375.365571992043, 5087.592992560586, 5124.590032797368, 5134.614903882224, 5134.921666450013, 5140.845774626767, 4229.767362795076, 4367.978160109179, 4368.803403846835, 4371.978140109279, 4373.322135069069, 2761.4891245119716, 2775.3755405033708, 2778.055361247135, 2789.288731373487, 2789.511835428792, 4924.4583095859425, 4939.851804445872, 4943.4809345018975, 4950.133726597831, 4954.256861470736, 5062.82280120194, 5335.679859208382, 5344.35867695879, 5351.464853514617, 5374.54316383104, 4904.6321525886415, 4924.655274130777, 4949.529794669501, 4950.950490495049, 4954.777035033432, 5207.3751149862255, 5214.608904332114, 5222.798756286, 5245.606579506629, 5261.763220655003, 4885.364902562644, 5118.41138269089, 5122.334096567422, 5122.871928201825, 5135.38375394955, 4915.164422048332, 4919.114559379203, 4933.77797999098, 4935.309056731989, 4944.728039957837, 3700.3339398908456, 3721.7580857244193, 3731.0, 3735.8132093395766, 3742.7192960527523, 5083.262926875656, 5232.581393488588, 5232.633715639869, 5241.633085683966, 5250.973745131403, 5057.468965758542, 5059.822906198413, 5074.949250507595, 5075.822346217865, 5091.6181286402925, 5041.470645582161, 5044.571211446922, 5055.595552355876, 5061.898762024665, 5071.898562028812, 4831.299461578122, 4970.390544963923, 4982.0, 4982.775775090057, 4983.900321993612, 4829.261465872213, 4922.1541921779335, 5067.341245638044, 5089.236614507853, 5112.412072611697, 4923.5814955729165, 4943.986482771095, 4946.975265123651, 4947.975260123676, 4980.750962451791], "value": 3824.455070236958, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [611.9694015299235, 675.2167485716567, 708.2881703887592, 708.6173466328183, 728.3372131360461, 12404.31776252307, 13254.7349053019, 14662.0, 15106.6978660427, 15303.15832629205, 14556.854431455682, 14730.0, 14852.702945941075, 14948.551543453686, 14959.700805983874, 615.5444970721657, 767.2021098058041, 776.6116941529235, 790.6600161930368, 799.8840168175611, 791.0586402181415, 794.3010151067053, 795.312055072364, 795.6857041468617, 797.4736673795296, 816.008549612221, 817.207308910359, 818.0183779464636, 819.9344052475817, 820.8276261984961, 638.5498223752267, 656.622442095792, 657.9638119903451, 659.2682122843639, 810.7000409848364, 577.4773829684143, 592.2271435776311, 596.573449983264, 596.8269201931435, 597.0566504922256, 12304.569340073143, 12325.69185770354, 12336.938315308456, 12378.44297006637, 12401.441935112942, 11404.600838970679, 11902.702432439259, 11962.282263064244, 12064.577739779153, 12232.491596659462, 11585.0, 11729.768374320744, 11760.17678762487, 11823.34971576563, 12173.634790956197, 4123.567025462313, 4126.5667104953845, 4135.8966025849295, 4198.3702444633245, 4215.367694845767, 64851.35148648547, 65396.67301663509, 65897.67051164714, 65965.0, 66020.66989665022, 9945.353552019096, 9957.203423726085, 9960.601575937026, 10065.194784417228, 10082.092611664986, 17210.483685489457, 17299.56751081233, 17314.480565583053, 17315.653686926442, 17475.47573572795, 6330.873382532323, 6434.67826608677, 6516.152900122954, 6625.635590042594, 6666.200055993312, 3679.411294192916, 3704.9629503705155, 3706.777593344408, 3708.721845861571, 3742.3825068863875, 2733.4259805440684, 2755.931101722473, 2768.0, 2784.053421836585, 2820.6756223034204, 491.80082066762304, 492.3599320882838, 494.9727764972889, 517.0512110277607, 520.536722317138, 462.82181360176577, 467.27105715084576, 480.603502110753, 486.7712175277614, 492.4632150955476, 6682.0, 6716.294789047178, 6775.830604234933, 6787.762428315084, 7004.824879378057, 404.47822309220777, 405.705863249142, 426.09242313871255, 471.4907899468634, 510.38498609175855, 3362.4451965425433, 3422.760406771502, 3438.7420943429343, 3614.8192590370377, 3659.5608526976935, 89103.0, 91965.54017229872, 94779.52610236904, 95242.0, 96915.51542242385, 82933.0, 83889.0, 84397.57801210954, 84889.57555212184, 87505.1249487497, 62988.370116299164, 72208.2779172212, 72435.27564724286, 72532.2746772536, 75966.0, 8035.4375193738215, 8052.194780521901, 8085.878711819445, 8133.918660813553, 8145.79635509117, 38609.03477413087, 39447.2110557793, 40529.189416210924, 41289.58710412977, 44500.0, 41580.37629435621, 43026.78486607672, 43121.568784311756, 63351.683241583494, 65412.67293663501, 11425.542978280775, 11578.652640420802, 11602.303861768321, 11742.941285293518, 11907.940460297643, 11613.477393517143, 12593.559225427067, 13263.336833158497, 13544.458221671417, 14116.45378293304, 10850.457477125954, 11146.219764616724, 11176.664700059011, 11496.137789665641, 11670.183087184156, 10954.397508137128, 11863.050955923332, 11878.821817672915, 12045.33750643723, 12341.50633974631, 11497.655070347902, 11554.42227888619, 11807.0, 11837.644870653894, 12209.145359824726, 9437.716868493957, 9836.3606365586, 9882.901170988485, 9893.307468477138, 9980.351277166961, 9514.19129374011, 9665.453527435577, 10164.847527287244, 10179.592816287266, 10189.74525636865], "value": 6371.042169280879, "unit": "score"}], "name": "dromaeo_css", "value": 6405.8544320409055, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 114.0, 114.0, 113.0, 114.0, 114.0, 112.0, 113.0, 113.0, 113.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 126.0, 128.0, 193.0, 133.0, 127.0, 149.0, 128.0, 166.0, 126.0], "value": 143.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 163.0, 163.0, 163.0, 163.0, 162.0, 163.0, 163.0, 163.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 89.0, 124.0, 77.0, 76.0, 76.0, 77.0, 118.0, 78.0], "value": 86.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 117.0, 86.0, 87.0, 86.0, 124.0, 86.0, 86.0, 141.0], "value": 98.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 146.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 96.0, 95.0, 95.0, 94.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 61.0, 62.0], "value": 61.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 63.0, 65.0, 64.0, 64.0, 64.0, 65.0, 64.0], "value": 64.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 80.0, 81.0, 80.0, 79.0, 83.0, 80.0, 80.0, 79.0], "value": 80.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 131.0, 131.0, 128.0, 129.0, 133.0, 145.0, 134.0, 174.0, 139.0], "value": 137.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 168.0, 170.0, 167.0, 172.0, 168.0, 169.0, 167.0, 169.0, 167.0], "value": 168.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 70.0, 68.0, 68.0, 68.0, 68.0, 69.0, 69.0, 68.0], "value": 68.5, "unit": "score"}], "name": "kraken", "value": 1543.3, "alertThreshold": 2.0}]} 07:59:11 INFO - Return code: 0 07:59:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:59:11 INFO - # TBPL SUCCESS # 07:59:11 INFO - Running post-action listener: _resource_record_post_action 07:59:11 INFO - ##### 07:59:11 INFO - ##### Finished run-tests step (success) 07:59:11 INFO - ##### 07:59:11 INFO - Running post-run listener: _resource_record_post_run 07:59:11 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 535699456; Read time: 8; Write time: 583548 07:59:11 INFO - TinderboxPrint: CPU usage
13.0% 07:59:11 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 07:59:11 INFO - TinderboxPrint: I/O write bytes / time
535,699,456 / 583,548 07:59:11 INFO - TinderboxPrint: CPU idle
8,331.7 (87.0%) 07:59:11 INFO - TinderboxPrint: CPU user
1,198.6 (12.5%) 07:59:11 INFO - TinderboxPrint: Swap in / out
0 / 0 07:59:11 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 252067840; Read time: 0; Write time: 273432 07:59:11 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 283348992; Read time: 0; Write time: 310088 07:59:12 INFO - Running post-run listener: _upload_blobber_files 07:59:12 INFO - Blob upload gear active. 07:59:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:59:12 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:59:12 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:59:12 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:59:12 INFO - (blobuploader) - INFO - Open directory for files ... 07:59:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:59:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:59:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:59:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:59:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:59:16 INFO - (blobuploader) - INFO - Done attempting. 07:59:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:59:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:59:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:59:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:59:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:59:17 INFO - (blobuploader) - INFO - Done attempting. 07:59:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:59:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:59:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:59:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:59:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:59:18 INFO - (blobuploader) - INFO - Done attempting. 07:59:18 INFO - (blobuploader) - INFO - Iteration through files over. 07:59:18 INFO - Return code: 0 07:59:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:59:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:59:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/16b098d221144075dd30270f713f6c582cb6ea2cdf4e8970e50b3337dc4afbc94bd783d2d1c97b97ec211a72bd174ad067df6e6cf2f979d07a6df7e88a6a35ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9e7a671a7d6c388c2ec3c71294c12da74bb4a6c77ead85748750ee332c949db982fe30a541d7be8faa2f99f73053be4fef1f21bef6061cc61d6f4a64de225658", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b4a49ff33604317e2abd9316ee55fddcd17e11807c563d650f79e7b13f557526032ae11bae3c2394924ebe42b355ebc5c7660d697c8bbc015254f871f1e8771f"} 07:59:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:59:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:59:18 INFO - Contents: 07:59:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/16b098d221144075dd30270f713f6c582cb6ea2cdf4e8970e50b3337dc4afbc94bd783d2d1c97b97ec211a72bd174ad067df6e6cf2f979d07a6df7e88a6a35ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9e7a671a7d6c388c2ec3c71294c12da74bb4a6c77ead85748750ee332c949db982fe30a541d7be8faa2f99f73053be4fef1f21bef6061cc61d6f4a64de225658", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b4a49ff33604317e2abd9316ee55fddcd17e11807c563d650f79e7b13f557526032ae11bae3c2394924ebe42b355ebc5c7660d697c8bbc015254f871f1e8771f"} 07:59:18 INFO - Running post-run listener: copy_logs_to_upload_dir 07:59:18 INFO - Copying logs to upload dir... 07:59:18 INFO - mkdir: /builds/slave/test/build/upload/logs 07:59:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.994083 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-07-08 07:59:16.944015) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 07:59:16.947971) ========= 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=52faae308a556c440401f8e5000001e8-1467988714.434558-1910852929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/16b098d221144075dd30270f713f6c582cb6ea2cdf4e8970e50b3337dc4afbc94bd783d2d1c97b97ec211a72bd174ad067df6e6cf2f979d07a6df7e88a6a35ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9e7a671a7d6c388c2ec3c71294c12da74bb4a6c77ead85748750ee332c949db982fe30a541d7be8faa2f99f73053be4fef1f21bef6061cc61d6f4a64de225658", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b4a49ff33604317e2abd9316ee55fddcd17e11807c563d650f79e7b13f557526032ae11bae3c2394924ebe42b355ebc5c7660d697c8bbc015254f871f1e8771f"} build_url:https://queue.taskcluster.net/v1/task/VrFiOJmLRLegbNzi_YLCtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011417 build_url: 'https://queue.taskcluster.net/v1/task/VrFiOJmLRLegbNzi_YLCtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/16b098d221144075dd30270f713f6c582cb6ea2cdf4e8970e50b3337dc4afbc94bd783d2d1c97b97ec211a72bd174ad067df6e6cf2f979d07a6df7e88a6a35ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9e7a671a7d6c388c2ec3c71294c12da74bb4a6c77ead85748750ee332c949db982fe30a541d7be8faa2f99f73053be4fef1f21bef6061cc61d6f4a64de225658", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b4a49ff33604317e2abd9316ee55fddcd17e11807c563d650f79e7b13f557526032ae11bae3c2394924ebe42b355ebc5c7660d697c8bbc015254f871f1e8771f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 07:59:16.973734) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 07:59:16.974056) ========= 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=52faae308a556c440401f8e5000001e8-1467988714.434558-1910852929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 07:59:17.057670) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 07:59:17.057980) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 07:59:17.058291) ========= ========= Total master_lag: 0.16 =========