builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-060 starttime: 1467950181.72 results: success (0) buildid: 20160707193126 builduid: 05d9e69d43af49f689844ea5c15d0981 revision: 9acdf39431fc0034073c9d9889b959ae3878daa4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 20:56:21.719664) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 20:56:21.720120) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 20:56:21.720411) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 20:56:21.737381) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 20:56:21.738004) ========= 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=337fe3f4b1febe37b85fccc40000019e-1467949022.735271-2059095193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-07 20:56:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.9M=0s 2016-07-07 20:56:21 (45.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.088349 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 20:56:21.841458) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 20:56:21.841786) ========= 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=337fe3f4b1febe37b85fccc40000019e-1467949022.735271-2059095193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014348 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 20:56:21.892603) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 20:56:21.893236) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 9acdf39431fc0034073c9d9889b959ae3878daa4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 9acdf39431fc0034073c9d9889b959ae3878daa4 --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=337fe3f4b1febe37b85fccc40000019e-1467949022.735271-2059095193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-07 20:56:22,117 truncating revision to first 12 chars 2016-07-07 20:56:22,117 Setting DEBUG logging. 2016-07-07 20:56:22,117 attempt 1/10 2016-07-07 20:56:22,117 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/9acdf39431fc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-07 20:56:22,418 unpacking tar archive at: mozilla-inbound-9acdf39431fc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.629566 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 20:56:22.536987) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 20:56:22.537312) ========= script_repo_revision: 9acdf39431fc0034073c9d9889b959ae3878daa4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 20:56:22.537732) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 20:56:22.538001) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 20:56:22.547287) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-07 20:56:22.547605) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1467949022.735271-2059095193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:56:22 INFO - MultiFileLogger online at 20160707 20:56:22 in /builds/slave/test 20:56:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 20:56:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:56:22 INFO - {'append_to_log': False, 20:56:22 INFO - 'base_work_dir': '/builds/slave/test', 20:56:22 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 20:56:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:56:22 INFO - 'branch': 'Mozilla-Inbound', 20:56:22 INFO - 'buildbot_json_path': 'buildprops.json', 20:56:22 INFO - 'config_files': ('talos/linux_config.py',), 20:56:22 INFO - 'default_actions': ('clobber', 20:56:22 INFO - 'read-buildbot-config', 20:56:22 INFO - 'download-and-extract', 20:56:22 INFO - 'populate-webroot', 20:56:22 INFO - 'create-virtualenv', 20:56:22 INFO - 'install', 20:56:22 INFO - 'run-tests'), 20:56:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:56:22 INFO - 'download_minidump_stackwalk': True, 20:56:22 INFO - 'download_symbols': 'ondemand', 20:56:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:56:22 INFO - 'tooltool.py': '/tools/tooltool.py', 20:56:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:56:22 INFO - '/tools/misc-python/virtualenv.py')}, 20:56:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:56:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:56:22 INFO - 'installer_path': 'installer.exe', 20:56:22 INFO - 'log_level': 'info', 20:56:22 INFO - 'log_name': 'talos', 20:56:22 INFO - 'log_to_console': True, 20:56:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:56:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:56:22 INFO - 'opt_config_files': (), 20:56:22 INFO - 'pip_index': False, 20:56:22 INFO - 'sps_profile': False, 20:56:22 INFO - 'sps_profile_interval': 0, 20:56:22 INFO - 'suite': 'dromaeojs', 20:56:22 INFO - 'system_bits': '32', 20:56:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:56:22 INFO - 'title': 'talos-linux64-ix-060', 20:56:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:56:22 INFO - 'use_talos_json': True, 20:56:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:56:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:56:22 INFO - 'work_dir': 'build'} 20:56:22 INFO - ##### 20:56:22 INFO - ##### Running clobber step. 20:56:22 INFO - ##### 20:56:22 INFO - Running pre-action listener: _resource_record_pre_action 20:56:22 INFO - Running main action method: clobber 20:56:22 INFO - rmtree: /builds/slave/test/build 20:56:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:56:23 INFO - Running post-action listener: _resource_record_post_action 20:56:23 INFO - ##### 20:56:23 INFO - ##### Finished clobber step (success) 20:56:23 INFO - ##### 20:56:23 INFO - ##### 20:56:23 INFO - ##### Running read-buildbot-config step. 20:56:23 INFO - ##### 20:56:23 INFO - Running pre-action listener: _resource_record_pre_action 20:56:23 INFO - Running main action method: read_buildbot_config 20:56:23 INFO - Using buildbot properties: 20:56:23 INFO - { 20:56:23 INFO - "project": "", 20:56:23 INFO - "product": "firefox", 20:56:23 INFO - "script_repo_revision": "production", 20:56:23 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 20:56:23 INFO - "repository": "", 20:56:23 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 20:56:23 INFO - "buildid": "20160707193126", 20:56:23 INFO - "pgo_build": "True", 20:56:23 INFO - "basedir": "/builds/slave/test", 20:56:23 INFO - "buildnumber": 1299, 20:56:23 INFO - "slavename": "talos-linux64-ix-060", 20:56:23 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:56:23 INFO - "platform": "ubuntu64_hw", 20:56:23 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 20:56:23 INFO - "branch": "mozilla-inbound", 20:56:23 INFO - "repo_path": "integration/mozilla-inbound", 20:56:23 INFO - "revision": "9acdf39431fc0034073c9d9889b959ae3878daa4", 20:56:23 INFO - "stage_platform": "linux64-pgo", 20:56:23 INFO - "builduid": "05d9e69d43af49f689844ea5c15d0981", 20:56:23 INFO - "slavebuilddir": "test" 20:56:23 INFO - } 20:56:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/Mam8ORD6QrC5eXEtslbDVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 20:56:23 INFO - Running post-action listener: _resource_record_post_action 20:56:23 INFO - ##### 20:56:23 INFO - ##### Finished read-buildbot-config step (success) 20:56:23 INFO - ##### 20:56:23 INFO - ##### 20:56:23 INFO - ##### Running download-and-extract step. 20:56:23 INFO - ##### 20:56:23 INFO - Running pre-action listener: _resource_record_pre_action 20:56:23 INFO - Running main action method: download_and_extract 20:56:23 INFO - mkdir: /builds/slave/test/build/tests 20:56:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:23 INFO - https://queue.taskcluster.net/v1/task/Mam8ORD6QrC5eXEtslbDVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:56:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mam8ORD6QrC5eXEtslbDVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:56:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mam8ORD6QrC5eXEtslbDVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:56:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mam8ORD6QrC5eXEtslbDVg/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 20:56:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mam8ORD6QrC5eXEtslbDVg/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 20:56:27 INFO - Downloaded 1361 bytes. 20:56:27 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:56:27 INFO - Using the following test package requirements: 20:56:27 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:56:27 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:56:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:56:27 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:56:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:56:27 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:56:27 INFO - u'jsshell-linux-x86_64.zip'], 20:56:27 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:56:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:56:27 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:56:27 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:56:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:56:27 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:56:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:56:27 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:56:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:56:27 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:56:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:56:27 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:56: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')]} 20:56:27 INFO - https://queue.taskcluster.net/v1/task/Mam8ORD6QrC5eXEtslbDVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:56:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mam8ORD6QrC5eXEtslbDVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:56:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mam8ORD6QrC5eXEtslbDVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:56:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mam8ORD6QrC5eXEtslbDVg/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 20:56:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mam8ORD6QrC5eXEtslbDVg/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 20:56:30 INFO - Downloaded 24304659 bytes. 20:56:30 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'] 20:56:30 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 20:56:32 INFO - Return code: 0 20:56:32 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 20:56:32 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')]} 20:56:32 INFO - https://queue.taskcluster.net/v1/task/Mam8ORD6QrC5eXEtslbDVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:56:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mam8ORD6QrC5eXEtslbDVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:56:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mam8ORD6QrC5eXEtslbDVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:56:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mam8ORD6QrC5eXEtslbDVg/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 20:56:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mam8ORD6QrC5eXEtslbDVg/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 20:56:37 INFO - Downloaded 24304659 bytes. 20:56:37 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'] 20:56:37 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 20:56:38 INFO - Return code: 0 20:56:38 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')]} 20:56:38 INFO - https://queue.taskcluster.net/v1/task/Mam8ORD6QrC5eXEtslbDVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:56:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mam8ORD6QrC5eXEtslbDVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:56:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mam8ORD6QrC5eXEtslbDVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:56:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mam8ORD6QrC5eXEtslbDVg/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 20:56:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mam8ORD6QrC5eXEtslbDVg/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 20:56:39 INFO - Downloaded 14403333 bytes. 20:56:39 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'] 20:56:39 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 20:56:40 INFO - Return code: 0 20:56: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')]} 20:56:40 INFO - https://queue.taskcluster.net/v1/task/Mam8ORD6QrC5eXEtslbDVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:56:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mam8ORD6QrC5eXEtslbDVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:56:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mam8ORD6QrC5eXEtslbDVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:56:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mam8ORD6QrC5eXEtslbDVg/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 20:56:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mam8ORD6QrC5eXEtslbDVg/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 20:56:41 INFO - Downloaded 60440615 bytes. 20:56:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Mam8ORD6QrC5eXEtslbDVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:56:41 INFO - mkdir: /builds/slave/test/properties 20:56:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:56:41 INFO - Writing to file /builds/slave/test/properties/build_url 20:56:41 INFO - Contents: 20:56:41 INFO - build_url:https://queue.taskcluster.net/v1/task/Mam8ORD6QrC5eXEtslbDVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:56:42 INFO - Running post-action listener: _resource_record_post_action 20:56:42 INFO - Running post-action listener: set_extra_try_arguments 20:56:42 INFO - ##### 20:56:42 INFO - ##### Finished download-and-extract step (success) 20:56:42 INFO - ##### 20:56:42 INFO - ##### 20:56:42 INFO - ##### Running populate-webroot step. 20:56:42 INFO - ##### 20:56:42 INFO - Running pre-action listener: _resource_record_pre_action 20:56:42 INFO - Running main action method: populate_webroot 20:56:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:56:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:56:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:56:42 INFO - '--tppagecycles', 20:56:42 INFO - '7'], 20:56:42 INFO - 'tests': ['tsvgm']}}, 20:56:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:56:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:56:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:56:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:56:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:56:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:56:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:56:42 INFO - 'talos_options': ['--disable-e10s'], 20:56:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:56:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:56:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:56:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:56:42 INFO - 'talos_options': ['--disable-e10s'], 20:56:42 INFO - 'tests': ['damp', 'tps']}, 20:56:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:56:42 INFO - 'tests': ['damp', 'tps']}, 20:56:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:56:42 INFO - 'tests': ['dromaeo_dom']}, 20:56:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:56:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:56:42 INFO - 'tests': ['basic_compositor_video']}, 20:56:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:56:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:56:42 INFO - 'tests': ['a11yr', 20:56:42 INFO - 'ts_paint', 20:56:42 INFO - 'tpaint', 20:56:42 INFO - 'sessionrestore', 20:56:42 INFO - 'sessionrestore_no_auto_restore', 20:56:42 INFO - 'tabpaint']}, 20:56:42 INFO - 'other-e10s': {'tests': ['a11yr', 20:56:42 INFO - 'ts_paint', 20:56:42 INFO - 'tpaint', 20:56:42 INFO - 'sessionrestore', 20:56:42 INFO - 'sessionrestore_no_auto_restore', 20:56:42 INFO - 'tabpaint']}, 20:56:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:56:42 INFO - 'ts_paint', 20:56:42 INFO - 'tpaint', 20:56:42 INFO - 'sessionrestore', 20:56:42 INFO - 'sessionrestore_no_auto_restore', 20:56:42 INFO - 'tabpaint']}, 20:56:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:56:42 INFO - 'ts_paint', 20:56:42 INFO - 'tpaint', 20:56:42 INFO - 'sessionrestore', 20:56:42 INFO - 'sessionrestore_no_auto_restore', 20:56:42 INFO - 'tabpaint']}, 20:56:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:56:42 INFO - 'tests': ['a11yr', 20:56:42 INFO - 'ts_paint', 20:56:42 INFO - 'tpaint', 20:56:42 INFO - 'sessionrestore', 20:56:42 INFO - 'sessionrestore_no_auto_restore', 20:56:42 INFO - 'tabpaint']}, 20:56:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:56:42 INFO - 'tests': ['a11yr', 20:56:42 INFO - 'ts_paint', 20:56:42 INFO - 'tpaint', 20:56:42 INFO - 'sessionrestore', 20:56:42 INFO - 'sessionrestore_no_auto_restore', 20:56:42 INFO - 'tabpaint']}, 20:56:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:56:42 INFO - 'tests': ['tsvgx', 20:56:42 INFO - 'tsvgr_opacity', 20:56:42 INFO - 'tart', 20:56:42 INFO - 'tscrollx', 20:56:42 INFO - 'cart']}, 20:56:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:56:42 INFO - 'tsvgr_opacity', 20:56:42 INFO - 'tart', 20:56:42 INFO - 'tscrollx', 20:56:42 INFO - 'cart']}, 20:56:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:56:42 INFO - 'talos_options': ['--disable-e10s'], 20:56:42 INFO - 'tests': ['tp5o']}, 20:56:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:56:42 INFO - 'tests': ['tp5o']}, 20:56:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:56:42 INFO - 'talos_options': ['--disable-e10s', 20:56:42 INFO - '--xperf_path', 20:56:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:56:42 INFO - 'tests': ['tp5n']}, 20:56:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:56:42 INFO - 'talos_options': ['--xperf_path', 20:56:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:56:42 INFO - 'tests': ['tp5n']}}, 20:56:42 INFO - 'talos.zip': {'path': '', 20:56:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:56:42 INFO - Running post-action listener: _resource_record_post_action 20:56:42 INFO - ##### 20:56:42 INFO - ##### Finished populate-webroot step (success) 20:56:42 INFO - ##### 20:56:42 INFO - ##### 20:56:42 INFO - ##### Running create-virtualenv step. 20:56:42 INFO - ##### 20:56:42 INFO - Running pre-action listener: _resource_record_pre_action 20:56:42 INFO - Running main action method: create_virtualenv 20:56:42 INFO - Creating virtualenv /builds/slave/test/build/venv 20:56:42 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 20:56:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:56:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:56:42 INFO - Using real prefix '/usr' 20:56:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:56:42 INFO - Installing distribute.............................................................................................................................................................................................done. 20:56:44 INFO - Installing pip.................done. 20:56:44 INFO - Return code: 0 20:56:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:56: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')]} 20:56:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56: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')]} 20:56:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:44 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 0xed2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1193180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11913b0>, '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 0x11922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1192740>, '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': '337fe3f4b1febe37b85fccc40000019e-1467949022.735271-2059095193', '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 20:56:44 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 20:56:44 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 20:56:44 INFO - Using env: {'DISPLAY': ':0', 20:56:44 INFO - 'HOME': '/home/cltbld', 20:56:44 INFO - 'LANG': 'en_US.UTF-8', 20:56:44 INFO - 'LANGUAGE': 'en_US:en', 20:56:44 INFO - 'LOGNAME': 'cltbld', 20:56:44 INFO - 'MAIL': '/var/mail/cltbld', 20:56:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:44 INFO - 'MOZ_NO_REMOTE': '1', 20:56:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:44 INFO - 'NO_EM_RESTART': '1', 20:56:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:44 INFO - 'PWD': '/builds/slave/test', 20:56:44 INFO - 'SHELL': '/bin/bash', 20:56:44 INFO - 'SHLVL': '1', 20:56:44 INFO - 'TERM': 'linux', 20:56:44 INFO - 'TMOUT': '86400', 20:56:44 INFO - 'USER': 'cltbld', 20:56:44 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1467949022.735271-2059095193', 20:56:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:44 INFO - '_': '/tools/buildbot/bin/python'} 20:56:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:45 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 20:56:45 INFO - Cleaning up... 20:56:45 INFO - Return code: 0 20:56:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:56:45 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')]} 20:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:45 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')]} 20:56:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:45 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 0xed2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1193180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11913b0>, '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 0x11922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1192740>, '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': '337fe3f4b1febe37b85fccc40000019e-1467949022.735271-2059095193', '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 20:56:45 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 20:56:45 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 20:56:45 INFO - Using env: {'DISPLAY': ':0', 20:56:45 INFO - 'HOME': '/home/cltbld', 20:56:45 INFO - 'LANG': 'en_US.UTF-8', 20:56:45 INFO - 'LANGUAGE': 'en_US:en', 20:56:45 INFO - 'LOGNAME': 'cltbld', 20:56:45 INFO - 'MAIL': '/var/mail/cltbld', 20:56:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:45 INFO - 'MOZ_NO_REMOTE': '1', 20:56:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:45 INFO - 'NO_EM_RESTART': '1', 20:56:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:45 INFO - 'PWD': '/builds/slave/test', 20:56:45 INFO - 'SHELL': '/bin/bash', 20:56:45 INFO - 'SHLVL': '1', 20:56:45 INFO - 'TERM': 'linux', 20:56:45 INFO - 'TMOUT': '86400', 20:56:45 INFO - 'USER': 'cltbld', 20:56:45 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1467949022.735271-2059095193', 20:56:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:45 INFO - '_': '/tools/buildbot/bin/python'} 20:56:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:45 INFO - Downloading/unpacking psutil>=3.1.1 20:56:45 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 20:56:45 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 20:56:45 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 20:56:45 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 20:56:45 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 20:56:45 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 20:56:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:56:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:56:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:56:47 INFO - Installing collected packages: psutil 20:56:47 INFO - Running setup.py install for psutil 20:56:47 INFO - building 'psutil._psutil_linux' extension 20:56:47 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 20:56:47 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 20:56:47 INFO - building 'psutil._psutil_posix' extension 20:56:47 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 20:56:47 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 20:56:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:56:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:56:47 INFO - Successfully installed psutil 20:56:47 INFO - Cleaning up... 20:56:47 INFO - Return code: 0 20:56:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:56:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1193180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11913b0>, '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 0x11922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1192740>, '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': '337fe3f4b1febe37b85fccc40000019e-1467949022.735271-2059095193', '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 20:56:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:56:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:56:47 INFO - Using env: {'DISPLAY': ':0', 20:56:47 INFO - 'HOME': '/home/cltbld', 20:56:47 INFO - 'LANG': 'en_US.UTF-8', 20:56:47 INFO - 'LANGUAGE': 'en_US:en', 20:56:47 INFO - 'LOGNAME': 'cltbld', 20:56:47 INFO - 'MAIL': '/var/mail/cltbld', 20:56:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:47 INFO - 'MOZ_NO_REMOTE': '1', 20:56:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:47 INFO - 'NO_EM_RESTART': '1', 20:56:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:47 INFO - 'PWD': '/builds/slave/test', 20:56:47 INFO - 'SHELL': '/bin/bash', 20:56:47 INFO - 'SHLVL': '1', 20:56:47 INFO - 'TERM': 'linux', 20:56:47 INFO - 'TMOUT': '86400', 20:56:47 INFO - 'USER': 'cltbld', 20:56:47 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1467949022.735271-2059095193', 20:56:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:47 INFO - '_': '/tools/buildbot/bin/python'} 20:56:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:56:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:56:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:56:49 INFO - Installing collected packages: mozsystemmonitor 20:56:49 INFO - Running setup.py install for mozsystemmonitor 20:56:50 INFO - Successfully installed mozsystemmonitor 20:56:50 INFO - Cleaning up... 20:56:50 INFO - Return code: 0 20:56:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:56:50 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')]} 20:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:50 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')]} 20:56:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:50 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 0xed2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1193180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11913b0>, '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 0x11922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1192740>, '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': '337fe3f4b1febe37b85fccc40000019e-1467949022.735271-2059095193', '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 20:56:50 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 20:56:50 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 20:56:50 INFO - Using env: {'DISPLAY': ':0', 20:56:50 INFO - 'HOME': '/home/cltbld', 20:56:50 INFO - 'LANG': 'en_US.UTF-8', 20:56:50 INFO - 'LANGUAGE': 'en_US:en', 20:56:50 INFO - 'LOGNAME': 'cltbld', 20:56:50 INFO - 'MAIL': '/var/mail/cltbld', 20:56:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:50 INFO - 'MOZ_NO_REMOTE': '1', 20:56:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:50 INFO - 'NO_EM_RESTART': '1', 20:56:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:50 INFO - 'PWD': '/builds/slave/test', 20:56:50 INFO - 'SHELL': '/bin/bash', 20:56:50 INFO - 'SHLVL': '1', 20:56:50 INFO - 'TERM': 'linux', 20:56:50 INFO - 'TMOUT': '86400', 20:56:50 INFO - 'USER': 'cltbld', 20:56:50 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1467949022.735271-2059095193', 20:56:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:50 INFO - '_': '/tools/buildbot/bin/python'} 20:56:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:50 INFO - Downloading/unpacking jsonschema==2.5.1 20:56:50 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 20:56:50 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 20:56:50 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 20:56:50 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 20:56:50 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 20:56:50 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 20:56:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:56:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:56: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 20:56: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 20:56: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 20:56: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 20:56: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 20:56: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 20:56:52 INFO - Downloading functools32-3.2.3-2.tar.gz 20:56:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:56:52 INFO - warning: no files found matching '*.txt' 20:56:52 INFO - no previously-included directories found matching 'build' 20:56:52 INFO - no previously-included directories found matching 'dist' 20:56:52 INFO - no previously-included directories found matching '.git*' 20:56:52 INFO - Installing collected packages: jsonschema, functools32 20:56:52 INFO - Running setup.py install for functools32 20:56:52 INFO - warning: no files found matching '*.txt' 20:56:52 INFO - no previously-included directories found matching 'build' 20:56:52 INFO - no previously-included directories found matching 'dist' 20:56:52 INFO - no previously-included directories found matching '.git*' 20:56:52 INFO - Successfully installed jsonschema functools32 20:56:52 INFO - Cleaning up... 20:56:52 INFO - Return code: 0 20:56:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:56: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')]} 20:56:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56: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')]} 20:56:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56: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', '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 0xed2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1193180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11913b0>, '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 0x11922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1192740>, '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': '337fe3f4b1febe37b85fccc40000019e-1467949022.735271-2059095193', '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 20:56: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:56: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 blobuploader==1.2.4 20:56:52 INFO - Using env: {'DISPLAY': ':0', 20:56:52 INFO - 'HOME': '/home/cltbld', 20:56:52 INFO - 'LANG': 'en_US.UTF-8', 20:56:52 INFO - 'LANGUAGE': 'en_US:en', 20:56:52 INFO - 'LOGNAME': 'cltbld', 20:56:52 INFO - 'MAIL': '/var/mail/cltbld', 20:56:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:52 INFO - 'MOZ_NO_REMOTE': '1', 20:56:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:52 INFO - 'NO_EM_RESTART': '1', 20:56:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:52 INFO - 'PWD': '/builds/slave/test', 20:56:52 INFO - 'SHELL': '/bin/bash', 20:56:52 INFO - 'SHLVL': '1', 20:56:52 INFO - 'TERM': 'linux', 20:56:52 INFO - 'TMOUT': '86400', 20:56:52 INFO - 'USER': 'cltbld', 20:56:52 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1467949022.735271-2059095193', 20:56:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:52 INFO - '_': '/tools/buildbot/bin/python'} 20:56:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:52 INFO - Downloading/unpacking blobuploader==1.2.4 20:56: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 20:56: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 20:56: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 20:56: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 20:56: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 20:56: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 20:56:54 INFO - Downloading blobuploader-1.2.4.tar.gz 20:56:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:56:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:56:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:56: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 20:56: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 20:56: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 20:56: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 20:56: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 20:56: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 20:56:55 INFO - Downloading docopt-0.6.1.tar.gz 20:56:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:56:55 INFO - Installing collected packages: blobuploader, requests, docopt 20:56:55 INFO - Running setup.py install for blobuploader 20:56:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:56:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:56:55 INFO - Running setup.py install for requests 20:56:55 INFO - Running setup.py install for docopt 20:56:55 INFO - Successfully installed blobuploader requests docopt 20:56:55 INFO - Cleaning up... 20:56:56 INFO - Return code: 0 20:56:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:56:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:56 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 0xed2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1193180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11913b0>, '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 0x11922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1192740>, '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': '337fe3f4b1febe37b85fccc40000019e-1467949022.735271-2059095193', '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 20:56:56 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 20:56:56 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 20:56:56 INFO - Using env: {'DISPLAY': ':0', 20:56:56 INFO - 'HOME': '/home/cltbld', 20:56:56 INFO - 'LANG': 'en_US.UTF-8', 20:56:56 INFO - 'LANGUAGE': 'en_US:en', 20:56:56 INFO - 'LOGNAME': 'cltbld', 20:56:56 INFO - 'MAIL': '/var/mail/cltbld', 20:56:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:56 INFO - 'MOZ_NO_REMOTE': '1', 20:56:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:56 INFO - 'NO_EM_RESTART': '1', 20:56:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:56 INFO - 'PWD': '/builds/slave/test', 20:56:56 INFO - 'SHELL': '/bin/bash', 20:56:56 INFO - 'SHLVL': '1', 20:56:56 INFO - 'TERM': 'linux', 20:56:56 INFO - 'TMOUT': '86400', 20:56:56 INFO - 'USER': 'cltbld', 20:56:56 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1467949022.735271-2059095193', 20:56:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:56 INFO - '_': '/tools/buildbot/bin/python'} 20:56:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:56:56 INFO - Running setup.py (path:/tmp/pip-uyipMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:56:56 INFO - Running setup.py (path:/tmp/pip-4cgrSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:56:56 INFO - Running setup.py (path:/tmp/pip-B9aJH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:56:56 INFO - Running setup.py (path:/tmp/pip-8nQuDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:56:56 INFO - Running setup.py (path:/tmp/pip-vQyH7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:56:56 INFO - Running setup.py (path:/tmp/pip-HrskBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:56:56 INFO - Running setup.py (path:/tmp/pip-sjn5qf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:56:56 INFO - Running setup.py (path:/tmp/pip-y1W15J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:56:56 INFO - Running setup.py (path:/tmp/pip-5pSo7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:56:56 INFO - Running setup.py (path:/tmp/pip-jFWnEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:56:56 INFO - Running setup.py (path:/tmp/pip-jTLo6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:56:57 INFO - Running setup.py (path:/tmp/pip-L4T0bn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:56:57 INFO - Running setup.py (path:/tmp/pip-qUBG9F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:56:57 INFO - Running setup.py (path:/tmp/pip-uO1V64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:56:57 INFO - Running setup.py (path:/tmp/pip-AHVOuB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:56:57 INFO - Running setup.py (path:/tmp/pip-3knJpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:56:57 INFO - Running setup.py (path:/tmp/pip-H7YxEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:56:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:56:57 INFO - Running setup.py install for manifestparser 20:56:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:56:57 INFO - Running setup.py install for mozcrash 20:56:57 INFO - Running setup.py install for mozdebug 20:56:57 INFO - Running setup.py install for mozdevice 20:56:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:56:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:56:57 INFO - Running setup.py install for mozfile 20:56:58 INFO - Running setup.py install for mozhttpd 20:56:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:56:58 INFO - Running setup.py install for mozinfo 20:56:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:56:58 INFO - Running setup.py install for mozInstall 20:56:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:56:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:56:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:56:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:56:58 INFO - Running setup.py install for mozleak 20:56:58 INFO - Running setup.py install for mozlog 20:56:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:56:58 INFO - Running setup.py install for moznetwork 20:56:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:56:58 INFO - Running setup.py install for mozprocess 20:56:58 INFO - Running setup.py install for mozprofile 20:56:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:56:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:56:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:56:58 INFO - Running setup.py install for mozrunner 20:56:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:56:58 INFO - Running setup.py install for mozscreenshot 20:56:59 INFO - Running setup.py install for moztest 20:56:59 INFO - Running setup.py install for mozversion 20:56:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:56:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:56:59 INFO - Cleaning up... 20:56:59 INFO - Return code: 0 20:56:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:56: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')]} 20:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56: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')]} 20:56:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:59 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 0xed2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1193180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11913b0>, '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 0x11922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1192740>, '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': '337fe3f4b1febe37b85fccc40000019e-1467949022.735271-2059095193', '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 20:56:59 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 20:56:59 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 20:56:59 INFO - Using env: {'DISPLAY': ':0', 20:56:59 INFO - 'HOME': '/home/cltbld', 20:56:59 INFO - 'LANG': 'en_US.UTF-8', 20:56:59 INFO - 'LANGUAGE': 'en_US:en', 20:56:59 INFO - 'LOGNAME': 'cltbld', 20:56:59 INFO - 'MAIL': '/var/mail/cltbld', 20:56:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:59 INFO - 'MOZ_NO_REMOTE': '1', 20:56:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:59 INFO - 'NO_EM_RESTART': '1', 20:56:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:59 INFO - 'PWD': '/builds/slave/test', 20:56:59 INFO - 'SHELL': '/bin/bash', 20:56:59 INFO - 'SHLVL': '1', 20:56:59 INFO - 'TERM': 'linux', 20:56:59 INFO - 'TMOUT': '86400', 20:56:59 INFO - 'USER': 'cltbld', 20:56:59 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1467949022.735271-2059095193', 20:56:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:59 INFO - '_': '/tools/buildbot/bin/python'} 20:56:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:56:59 INFO - Running setup.py (path:/tmp/pip-z5xvvv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:56:59 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)) 20:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:56:59 INFO - Running setup.py (path:/tmp/pip-jxP7n3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:56:59 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)) 20:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:56:59 INFO - Running setup.py (path:/tmp/pip-VCLvAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:56:59 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)) 20:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:56:59 INFO - Running setup.py (path:/tmp/pip-CO0lCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:56:59 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)) 20:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:56:59 INFO - Running setup.py (path:/tmp/pip-X_o0gy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:56:59 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)) 20:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:56:59 INFO - Running setup.py (path:/tmp/pip-plOIfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:56:59 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)) 20:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:56:59 INFO - Running setup.py (path:/tmp/pip-quM4A7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:57:00 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)) 20:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:57:00 INFO - Running setup.py (path:/tmp/pip-Ihi1qM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:57:00 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)) 20:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:57:00 INFO - Running setup.py (path:/tmp/pip-LC4igX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:57:00 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)) 20:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:57:00 INFO - Running setup.py (path:/tmp/pip-cr4zhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:57:00 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)) 20:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:57:00 INFO - Running setup.py (path:/tmp/pip-KXXVJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:57:00 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)) 20:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:57:00 INFO - Running setup.py (path:/tmp/pip-hgjFm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:57:00 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)) 20:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:57:00 INFO - Running setup.py (path:/tmp/pip-4ziJ5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:57:00 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)) 20:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:57:00 INFO - Running setup.py (path:/tmp/pip-DZ6V_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:57:00 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)) 20:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:57:00 INFO - Running setup.py (path:/tmp/pip-9FZHKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:57:00 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)) 20:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:57:00 INFO - Running setup.py (path:/tmp/pip-kik4qO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:57:00 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)) 20:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:57:00 INFO - Running setup.py (path:/tmp/pip-dtN07n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:57:00 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)) 20:57:00 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)) 20:57:00 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)) 20:57:00 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)) 20:57:00 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)) 20:57:00 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)) 20:57:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:57:00 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 20:57:00 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 20:57:00 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 20:57:00 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 20:57:00 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 20:57:00 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 20:57:02 INFO - Downloading blessings-1.6.tar.gz 20:57:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:57:02 INFO - Installing collected packages: blessings 20:57:02 INFO - Running setup.py install for blessings 20:57:02 INFO - Successfully installed blessings 20:57:02 INFO - Cleaning up... 20:57:02 INFO - Return code: 0 20:57:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:57:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:57:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:57:03 INFO - Reading from file tmpfile_stdout 20:57:03 INFO - Current package versions: 20:57:03 INFO - argparse == 1.2.1 20:57:03 INFO - blessings == 1.6 20:57:03 INFO - blobuploader == 1.2.4 20:57:03 INFO - docopt == 0.6.1 20:57:03 INFO - functools32 == 3.2.3-2 20:57:03 INFO - jsonschema == 2.5.1 20:57:03 INFO - manifestparser == 1.1 20:57:03 INFO - mozInstall == 1.12 20:57:03 INFO - mozcrash == 0.17 20:57:03 INFO - mozdebug == 0.1 20:57:03 INFO - mozdevice == 0.48 20:57:03 INFO - mozfile == 1.2 20:57:03 INFO - mozhttpd == 0.7 20:57:03 INFO - mozinfo == 0.9 20:57:03 INFO - mozleak == 0.1 20:57:03 INFO - mozlog == 3.2 20:57:03 INFO - moznetwork == 0.27 20:57:03 INFO - mozprocess == 0.23 20:57:03 INFO - mozprofile == 0.28 20:57:03 INFO - mozrunner == 6.12 20:57:03 INFO - mozscreenshot == 0.1 20:57:03 INFO - mozsystemmonitor == 0.3 20:57:03 INFO - moztest == 0.7 20:57:03 INFO - mozversion == 1.4 20:57:03 INFO - psutil == 3.1.1 20:57:03 INFO - requests == 1.2.3 20:57:03 INFO - wsgiref == 0.1.2 20:57:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:57: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')]} 20:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57: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')]} 20:57:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:03 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 0xed2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1193180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11913b0>, '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 0x11922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1192740>, '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': '337fe3f4b1febe37b85fccc40000019e-1467949022.735271-2059095193', '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 20:57:03 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 20:57:03 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 20:57:03 INFO - Using env: {'DISPLAY': ':0', 20:57:03 INFO - 'HOME': '/home/cltbld', 20:57:03 INFO - 'LANG': 'en_US.UTF-8', 20:57:03 INFO - 'LANGUAGE': 'en_US:en', 20:57:03 INFO - 'LOGNAME': 'cltbld', 20:57:03 INFO - 'MAIL': '/var/mail/cltbld', 20:57:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:03 INFO - 'MOZ_NO_REMOTE': '1', 20:57:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:03 INFO - 'NO_EM_RESTART': '1', 20:57:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:03 INFO - 'PWD': '/builds/slave/test', 20:57:03 INFO - 'SHELL': '/bin/bash', 20:57:03 INFO - 'SHLVL': '1', 20:57:03 INFO - 'TERM': 'linux', 20:57:03 INFO - 'TMOUT': '86400', 20:57:03 INFO - 'USER': 'cltbld', 20:57:03 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1467949022.735271-2059095193', 20:57:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:03 INFO - '_': '/tools/buildbot/bin/python'} 20:57:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:03 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)) 20:57:03 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)) 20:57:03 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)) 20:57:03 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)) 20:57:03 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)) 20:57:03 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)) 20:57:03 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)) 20:57:03 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)) 20:57:03 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)) 20:57:03 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)) 20:57:03 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)) 20:57:03 INFO - Cleaning up... 20:57:03 INFO - Return code: 0 20:57:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:57: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')]} 20:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:57:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57: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')]} 20:57:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:57:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:57:03 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 0xed2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1193180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11913b0>, '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 0x11922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1192740>, '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': '337fe3f4b1febe37b85fccc40000019e-1467949022.735271-2059095193', '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 20:57:03 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 20:57:03 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 20:57:03 INFO - Using env: {'DISPLAY': ':0', 20:57:03 INFO - 'HOME': '/home/cltbld', 20:57:03 INFO - 'LANG': 'en_US.UTF-8', 20:57:03 INFO - 'LANGUAGE': 'en_US:en', 20:57:03 INFO - 'LOGNAME': 'cltbld', 20:57:03 INFO - 'MAIL': '/var/mail/cltbld', 20:57:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:03 INFO - 'MOZ_NO_REMOTE': '1', 20:57:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:03 INFO - 'NO_EM_RESTART': '1', 20:57:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:03 INFO - 'PWD': '/builds/slave/test', 20:57:03 INFO - 'SHELL': '/bin/bash', 20:57:03 INFO - 'SHLVL': '1', 20:57:03 INFO - 'TERM': 'linux', 20:57:03 INFO - 'TMOUT': '86400', 20:57:03 INFO - 'USER': 'cltbld', 20:57:03 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1467949022.735271-2059095193', 20:57:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:03 INFO - '_': '/tools/buildbot/bin/python'} 20:57:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:57:03 INFO - Cleaning up... 20:57:03 INFO - Return code: 0 20:57:03 INFO - Running post-action listener: _resource_record_post_action 20:57:03 INFO - Running post-action listener: _start_resource_monitoring 20:57:03 INFO - Starting resource monitoring. 20:57:03 INFO - ##### 20:57:03 INFO - ##### Finished create-virtualenv step (success) 20:57:03 INFO - ##### 20:57:03 INFO - ##### 20:57:03 INFO - ##### Running install step. 20:57:03 INFO - ##### 20:57:03 INFO - Running pre-action listener: _resource_record_pre_action 20:57:03 INFO - Running main action method: install 20:57:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:57:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:57:03 INFO - Reading from file tmpfile_stdout 20:57:03 INFO - Detecting whether we're running mozinstall >=1.0... 20:57:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:57:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:57:03 INFO - Reading from file tmpfile_stdout 20:57:03 INFO - Output received: 20:57:03 INFO - Usage: mozinstall [options] installer 20:57:03 INFO - Options: 20:57:03 INFO - -h, --help show this help message and exit 20:57:03 INFO - -d DEST, --destination=DEST 20:57:03 INFO - Directory to install application into. [default: 20:57:03 INFO - "/builds/slave/test"] 20:57:03 INFO - --app=APP Application being installed. [default: firefox] 20:57:03 INFO - mkdir: /builds/slave/test/build/application 20:57:03 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'] 20:57:03 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 20:57:21 INFO - Reading from file tmpfile_stdout 20:57:21 INFO - Output received: 20:57:21 INFO - /builds/slave/test/build/application/firefox/firefox 20:57:21 INFO - Running post-action listener: _resource_record_post_action 20:57:21 INFO - ##### 20:57:21 INFO - ##### Finished install step (success) 20:57:21 INFO - ##### 20:57:21 INFO - ##### 20:57:21 INFO - ##### Running run-tests step. 20:57:21 INFO - ##### 20:57:21 INFO - Running pre-action listener: _resource_record_pre_action 20:57:21 INFO - Running main action method: run_tests 20:57:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:57:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:57:21 INFO - Python 2.7.3 20:57:21 INFO - Return code: 0 20:57:21 INFO - grabbing minidump binary from tooltool 20:57:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:57:21 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 0x11913b0>, '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 0x11922b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1192740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:57:21 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 20:57:21 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 20:57:21 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 20:57:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:57:21 INFO - Return code: 0 20:57:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:57:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:57:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:57:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:57:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:57:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Mam8ORD6QrC5eXEtslbDVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 20:57:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Mam8ORD6QrC5eXEtslbDVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --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 20:57:21 INFO - Using env: {'DISPLAY': ':0', 20:57:21 INFO - 'HOME': '/home/cltbld', 20:57:21 INFO - 'LANG': 'en_US.UTF-8', 20:57:21 INFO - 'LANGUAGE': 'en_US:en', 20:57:21 INFO - 'LOGNAME': 'cltbld', 20:57:21 INFO - 'MAIL': '/var/mail/cltbld', 20:57:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:57:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:57:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:21 INFO - 'MOZ_NO_REMOTE': '1', 20:57:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:57:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:21 INFO - 'NO_EM_RESTART': '1', 20:57:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:21 INFO - 'PWD': '/builds/slave/test', 20:57:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:57:21 INFO - 'SHELL': '/bin/bash', 20:57:21 INFO - 'SHLVL': '1', 20:57:21 INFO - 'TERM': 'linux', 20:57:21 INFO - 'TMOUT': '86400', 20:57:21 INFO - 'USER': 'cltbld', 20:57:21 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1467949022.735271-2059095193', 20:57:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:21 INFO - '_': '/tools/buildbot/bin/python'} 20:57:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Mam8ORD6QrC5eXEtslbDVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 20:57:21 INFO - mozversion application_buildid: 20160707193126 20:57:21 INFO - mozversion application_changeset: 9acdf39431fc0034073c9d9889b959ae3878daa4 20:57:21 INFO - mozversion application_display_name: Nightly 20:57:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:57:21 INFO - mozversion application_name: Firefox 20:57:21 INFO - mozversion application_remotingname: firefox 20:57:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 20:57:21 INFO - mozversion application_vendor: Mozilla 20:57:21 INFO - mozversion application_version: 50.0a1 20:57:21 INFO - mozversion platform_buildid: 20160707193126 20:57:21 INFO - mozversion platform_changeset: 9acdf39431fc0034073c9d9889b959ae3878daa4 20:57:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 20:57:21 INFO - mozversion platform_version: 50.0a1 20:57:21 INFO - using testdate: 1467950241 20:57:21 INFO - actual date: 1467950241 20:57:21 INFO - starting webserver on 'localhost:42210' 20:57:21 INFO - SUITE-START | Running 2 tests 20:57:21 INFO - TEST-START | dromaeo_css 20:57:21 INFO - operating with platform_type : linux_ 20:57:21 INFO - Initialising browser for dromaeo_css test... 20:57:21 INFO - TEST-INFO | started process 7641 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeSW_uu/profile http://localhost:42210/getInfo.html) 20:57:25 INFO - PROCESS | 7641 | __metrics Screen width/height:1600/1200 20:57:25 INFO - PROCESS | 7641 | colorDepth:24 20:57:25 INFO - PROCESS | 7641 | Browser inner width/height: 1024/697 20:57:25 INFO - PROCESS | 7641 | __metrics 20:57:26 INFO - PROCESS | 7641 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:57:27 INFO - TEST-INFO | 7641: exit 0 20:57:27 INFO - Browser initialized. 20:57:27 INFO - Running cycle 1/1 for dromaeo_css test... 20:57:27 INFO - TEST-INFO | started process 7724 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeSW_uu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:57:39 INFO - PROCESS | 7724 | RSS: Main: 157949952 20:57:39 INFO - PROCESS | 7724 | 20:58:30 INFO - PROCESS | 7724 | 1467950310495 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] 21:00:38 INFO - PROCESS | 7724 | Cycle 1(1): loaded http://localhost:42210/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42210/tests/dromaeo/cssquery-ext.html) 21:00:39 INFO - PROCESS | 7724 | RSS: Main: 287784960 21:00:39 INFO - PROCESS | 7724 | 21:03:42 INFO - PROCESS | 7724 | Cycle 1(1): loaded http://localhost:42210/tests/dromaeo/cssquery-ext.html (next: http://localhost:42210/tests/dromaeo/cssquery-jquery.html) 21:03:42 INFO - PROCESS | 7724 | RSS: Main: 246456320 21:03:42 INFO - PROCESS | 7724 | 21:06:44 INFO - PROCESS | 7724 | Cycle 1(1): loaded http://localhost:42210/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42210/tests/dromaeo/cssquery-mootools.html) 21:06:45 INFO - PROCESS | 7724 | RSS: Main: 245743616 21:06:45 INFO - PROCESS | 7724 | 21:09:47 INFO - PROCESS | 7724 | Cycle 1(1): loaded http://localhost:42210/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42210/tests/dromaeo/cssquery-prototype.html) 21:09:47 INFO - PROCESS | 7724 | RSS: Main: 240480256 21:09:47 INFO - PROCESS | 7724 | 21:12:50 INFO - PROCESS | 7724 | Cycle 1(1): loaded http://localhost:42210/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42210/tests/dromaeo/cssquery-yui.html) 21:12:50 INFO - PROCESS | 7724 | RSS: Main: 229978112 21:12:50 INFO - PROCESS | 7724 | 21:15:53 INFO - PROCESS | 7724 | Cycle 1(1): loaded http://localhost:42210/tests/dromaeo/cssquery-yui.html (next: http://localhost:42210/tests/dromaeo/cssquery-dojo.html) 21:15:54 INFO - PROCESS | 7724 | RSS: Main: 275742720 21:15:54 INFO - PROCESS | 7724 | 21:15:54 INFO - PROCESS | 7724 | __start_tp_report 21:15:54 INFO - PROCESS | 7724 | _x_x_mozilla_page_load 21:15:54 INFO - PROCESS | 7724 | _x_x_mozilla_page_load_details 21:15:54 INFO - PROCESS | 7724 | |i|pagename|runs| 21:15:54 INFO - PROCESS | 7724 | |0;dojo.html;2962.0965605490323;2992.91021269362;3016.215783896186;3022.8790848366066;3037.620297462816;5131.769070391832;5170.715610641413;5244.344456942882;5279.8944021119605;5317.627766056383;5259.684418934857;5299.205119232117;5337.332833395825;5398.541124004454;5452.318460192476;4739.691920025204;4784.282357646363;4807.134715751164;4819.710817350952;4961.5286547777905;4880.567082977591;4880.65835391521;4899.1426500362295;4928.088303663816;4949.034938187055;4724.881877953061;4773.64197685175;4782.545658162469;4839.128956787777;4866.099771542258;4766.690165139289;4778.569928706398;4783.952160478386;4820.855374338776;4885.022995400934;4758.238681810928;4770.761461926924;4777.761111944389;4811.759412029384;4824.107540105092;5190.480951904817;5209.114450543417;5288.735563221823;5335.386430560497;5342.946570534284;5660.943390566083;5698.658080515141;5699.401562835884;5701.173329867188;5710.400407957146;5697;5724.16999535065;5724.570657200727;5736.397678243766;5739.655620662774;5198.012377648235;5224.08578498765;5279.604029697788;5287.286216360742;5364.383095943938;5791.88416231673;5796.246487956623;5800.796972105956;5813.6221145625395;5823.155642431823;5602.803901863415;5609.943900560942;5613.915791263134;5620.859478512988;5620.887582248414;5497.175423686399;5567.582431317667;5614.29821272341;5634.436556344414;5689;5590.692511911884;5631.042722737145;5644.379118296984;5652.293463317085;5653.462921022497;5602.887942241132;5620.971895140498;5627.887442251132;5632;5647.0964645656495;4228.957710422918;4266.807993640294;4287.935680964788;4324.783760811947;4329.1341731653165;3877.3990031545154;3878.592747761501;3885.0287428142965;3916.118873253495;3918.059665680273;5356.3572371315695;5401.4868587484125;5403.972980135153;5408.972955135199;5411.296531450965;5560.165975103767;5634.239377684042;5704.172894930295;5720.914186287209;5755.079187330007;5406.513413792777;5417.972910135424;5421.2952316199435;5421.945780542223;5442.673439593637;4794;4962.354893863775;4968.925466118011;4975;5015.498450155028;5747.597668163188;5800.854978625568;5804.129380592861;5810.82567522975;5836.037053886146;5660.54715622741;5665;5669.659820410789;5671.064274394678;5671.149327600893;5672.914906276492;5709.543236540983;5806.390329015392;5826.504747096545;5827.388124246893;5535.778568857361;5546.278983732089;5549.056660367828;5549.250851135045;5612.747426365905;5632.605717599892;5643.492085712305;5644.774209031592;5650.350209725934;5651.915221271766;5373.516383525345;5473.288472498709;5521.779128834802;5533.391326954113;5534.446555344433;5552.139418390156;5552.52803511706;5558.833235002957;5563.193336966198;5593.049181639212;5445.863853403696;5475.479829416199;5492.231087647812;5501.889962200814;5504.614676972574;5420.512153906167;5494.560435165097;5546.362168350692;5563.304586926634;5605.719714014364;5333.599980001593;5387.218853266333;5396;5405.081136206933;5435.83692489226 21:15:54 INFO - PROCESS | 7724 | |1;ext.html;565.6549504802073;610.7007566292515;617.8084793713949;619.8295468746094;646.1535388640883;30732.692673073263;42752.358714619266;43437.34843977335;43455;43463.78268108659;46261;46802.53197468024;46837.297440538416;46904.76547617266;46927.76536117323;8910.287177025855;9026.323025773061;9040.502772347518;9044.095590440937;9052.728418147433;8891.510966896818;8953;8967.506787126706;8969.10308969101;8980.101989801033;9006.459612423243;9028.187463128317;9036.141566551167;9042.593083311234;9053.230475409599;8933.463992160427;8968.865467018;8970.686025989091;8972.147645973622;8981.775455613597;8950.641974321019;9023.458592484472;9024;9024.097590240988;9025.864612030824;38208.80895595532;38601.61398386008;38733.612663873566;38751.22497550033;38778.224435511416;3455.1707590178426;3462.5498685170764;3519.5072689823446;3614.4036234021355;3916.74541154824;31157.688423115706;31819.522707159413;32149.51775723366;32571.098772066154;33960.15099622529;4382.076319415316;4426.336049592587;4448.154850578412;4517.796699148514;4615.607673347769;373598;375697;376224;376859;377063;53988.460115398346;60016;62082;63055.369446305864;63093;60211;65776;66067;66104.66947665231;66220;17328.566785830204;17691.73462398065;17694.380696675555;17698.734518982226;17711;12081.637550873487;12600.936995315147;12703.36483175856;12827.615171544869;13071.477140914258;19621.60756784856;19760.308389206308;19919;19922.30271940475;19932.302369417;6923.757668481579;7150.5352152109945;7205.2434494378385;7209.2069872314005;7266.818329541804;929.9488528131018;976.1751320134617;1001.3891526169031;1044.5560636729513;1154.1171004181808;32867.50698739521;34194.31611367759;34204.48693269603;34390.48414273788;34723;1090.0843291634906;1099.5272033025876;1119.2804767637367;1130.513879032024;1130.6438471881331;17812.643747124985;17960.910195448938;17971.281148753904;18041.7293740594;18045.368412105512;617406;622997;623878;901977;903939;58679.70660146672;60019;60116.69941650264;60232.39767602268;60257.698711506164;1196;1319.617310979805;1340.3633274194679;1354.2213227394288;1381.7789153735355;32949.67050329466;34993.65006349904;35080;35262.16484607746;35665.28669426649;52167;54980.72509637426;56933;57231.42768572261;61297.38702612917;523573;524954;530041;531081;532277;36308.45537316995;43556.34665480084;44527.55472445234;45145;48394.758026209645;49776;49792.75103624459;50565.74717126391;51160;51746;42661.78669106759;42959.1408171841;43528.129437411706;43559.34660980025;44820.32769508395;41746.58253417427;42501.78749106234;42538.14923701447;42698.71251443804;43646.12707745764;41628.58371416247;41918.790406047774;42451.150976980905;42829;42894;37031;38325.30426595101;38385.42421863618;38874.80562597169;38913.41629875611;28740.08320673584;28879.42241155207;29063;29247.85376073106;29531.261718457212 21:15:54 INFO - PROCESS | 7724 | |2;jquery.html;383.9731218814682;396.9761814291142;397.3245482679446;400.78557971485225;412.38966329831845;18743.62512749746;20525.281615143474;20539;20543.075561599744;21382;19468.12393442295;19537.804621953775;19932.900335498303;19985.400437986846;19991.700124498144;5625.38120806711;5634.549236061126;5839.240898683186;5843.561732870031;5844.386339434362;5748.19525266463;5802.12968054791;5809.419058094178;5817.8836423271505;5821.068629019358;5569.8607534811545;5774.480296773289;5778.451047150535;5779.884402311972;5780.797672081478;5513.283273174502;5722.885542289152;5768.884622307552;5776.768929242825;5790.392008839074;5642.633228840113;5677;5716.771329146829;5719.456651618131;5722.284714410699;13648.863511364858;13660.590182294547;13825.861741382558;13896.027278090538;14115.435382584787;2327.627579587275;2570.1646964736537;2670.586059160833;2766.529689952693;2823.378856651533;10169.389836609753;10290.794184116276;10363.740906477398;11443.370614616193;15202.847971520365;1873.6346412449577;1917.1564511614984;1953.6092781443767;2007.207153174488;2078.5738923520644;50897.492810407;65994.34005659929;68211.31788682149;79313.60343198305;85574.57212713959;10526.578936842594;11052;11131.67767032587;11252.43737813106;11273.661790146309;15542.5337239883;15623.3750649975;15637;15678.216089195723;15685.13731744765;7055.964720176366;7759;7776.066871975399;8065.072516660542;8102.311303539265;7906.288434040964;8066.274035336848;8172.6730930762105;8233.34133269337;8460;4712;4712.976435117871;4722.858314250578;4798.592119669797;4900.681455705368;1905.1902941250191;1905.6650860993261;1909.8281154695867;1936.94189174325;1968.4389948864505;787.5353541410595;873.921347078766;981.3719219699256;1049.1606714628267;1106.363840791548;18859.81140188608;20728.792712072685;22080.779192207872;22120.668189977165;22167.44581385446;922.5018490015451;938.3525367496405;968.5835090910836;978.574320170728;998.6205242007991;11167.218294719292;11454.828177577343;11538.250013749248;11562.595309164139;11624.825627615592;489014;495756;508087;509026;512062;86715;89282.55358723165;90452.54773726089;99838;101358;991.3605724307781;1012.21047582884;1043.3062013760764;1045.2265323660436;1049.186880167876;18017.90991045089;18209;18457.353992610195;18500.37678975151;18672.533186670444;32783.83608081944;39851;41986.1602767949;42829.78585107055;43821.46624868114;47129.381332613586;47593.28610070921;58912.410875890695;60299.39700602938;61765.691171543855;8580.871286930576;8707.3034157266;8711.695090671796;8776.736697899074;8918.910810891808;12917;13293.20240785556;14014;14283.714325713636;14364.414610148106;12468.563600273947;12488.812667809809;12539.37303134858;12549;12632.305223212812;11344.149188810707;12196.878031219574;12244.081693873173;12413.44139513706;12445.37773111359;11980.58067967617;12392.690182745504;12433;12651.746965060831;12778.936105319413;8713;8768.736937891874;8860.246879015356;9077.09229077087;9179.357444978787;11872;12489.250644961332;12647.241165530098;12676.429560669607;12686.746265074831 21:15:54 INFO - PROCESS | 7724 | |3;mootools.html;1407.2822860341225;1460.7297649934762;1549.2021608871432;1697.6434948660774;1726.4130195733449;8023.398245131617;8469;8550.273226775724;8554.871676924851;8557.828843423127;7351.522151060178;8017.19828017198;8262.91737082629;8274.710385136521;8406.159384061591;2204.1293688992837;2214.3799736073843;2227.387468446174;2235.3182279404773;2237.3511681612313;2227.5433536125056;2250.2124256510174;2278.2140161644206;2278.646809744492;2279.555486680098;1951.6974868895272;2024.4230394337617;2025.250657256817;2175.869447833127;2243.1139699818564;2227.866328020324;2245.191730976847;2246.6068438023362;2248.977510224893;2250.2124256510256;2223.9555208895895;2255.537614788964;2260.7174103237094;2261.705978222837;2262.151693115082;8416.368772342099;8455.95772021136;8456.238938495564;8461.873071903927;8479.66081356745;4955.776990035457;5053.4946505349535;5083.822066227664;5087.949120508822;5091.032703786269;3236.433624115794;3383.035834787074;3396.117009577503;3402.1834759657504;3444.603870554868;1049.564430761233;1088.0751361342875;1098.214776434845;1124.0726400719439;1130.107215299912;11078.667639970734;11092.722681933015;11093.278936869077;11156.16328775345;11156.888431115665;4256.489221293403;4310.590493903074;4436.778161091933;4436.844710435119;4514.232580461329;10025.749356266006;10029.749256268506;10036.046575575454;10044.748881277881;10046.799064018678;5050.393952725696;5076.82231121909;5080.695158290514;5092.134337162691;5097.108006098918;4783.856484305476;4892.657513974059;4904.705717656881;4908.828191013297;4910.238912968495;3884.7280690351404;3994.7403418777685;4008.6793056555407;4037.818298176589;4096.549379568245;1221.5785553983862;1238.7150955280156;1281.2056524954587;1286.2796833773118;1296.572131196703;961.4375590279625;965.1747755668943;983.2969426859687;994.8955359687274;996.7308826616772;6218.720157592919;6253.874922501524;6259;6303.149074874925;6303.401176888188;437.5733659681785;437.6083405352192;448.2737964497535;451.43570536828963;453.12546784705177;4063.227986682521;4136.21411931732;4202.411662367271;4208.7685177314925;4214.452121224222;10423.42671153094;10878.510467029002;11000.724981875517;11046;11052;10885.455727213608;10909.34543927367;10910.890891090987;10920.50857711405;10921;7464.888026679496;8137.674493020213;8156.592170391456;8198.8360232795;8249.752507424786;6290.528210384331;6366.745330186741;6451.612903225821;6498.285188629153;6509.251436084722;9924.255680823822;10173.898261017592;10290.897091028994;10296;10298.22763292741;10355.275130740776;10429.53067111997;10459.790804184026;10597.841032384365;10598.25812193139;7594.924050759421;7666.425018123775;7713.151553329241;7773.68905243784;7776.455648104578;8476.449030812977;8546.658133674584;8564.48613083217;8565.357598180286;8573.699920503002;7261.927380726125;7436.293552112541;7485.1766305707415;7545.132309784445;7569.280918312751;7381.704731810667;7401.888971665322;7414.406847452299;7416.221296763762;7591.620418978919;7192.42460603161;7199.2440793718;7234.96382518084;7249.42004639617;7280.017197678246;5053.343065401475;5271.630985830955;5272.340957380327;5277.822002865829;5380.408155103014;5130.947620951649;5181.248718935658;5222.660527065728;5409.78360865561;5440.483154100354 21:15:54 INFO - PROCESS | 7724 | |4;prototype.html;326.08045312219537;332.60918420855495;332.683950247265;341.0671812592561;341.45196958881013;5280.5775537956915;5296.841094767154;5314.627976041674;5324.178185561654;5365.919511207325;5199.4800519947985;5213.895722085556;5306.416294207644;5314.92027619586;5322.547583455411;3764.3788774852255;3983.4547252944903;3991.381335892941;4115.464989551369;4119.196756632443;4134.772587507686;4135.152293779783;4139.482564679415;4140.213359461708;4143.295639741251;4084.9591504085024;4098.52866920305;4099.7745124018165;4101.753894766309;4117.423560701504;3925.646691797752;4015.5984401559904;4105.50733911931;4108.322126849066;4144.834206631731;3661.2311414602964;3683.4843121962945;3684.8576941148062;3693.7968411737343;3696.482492451059;5125.333706618116;5139.229115632647;5142.537171654569;5181.248718935771;5219.8434046978655;4491.438570178728;4700.790628404644;4769.618430525549;4771.093492236499;4795.568398844086;5448;5450.645708029005;5492.917606235909;5496.395396506381;5498.900219956025;3971.4241434992055;3989.8803035908677;3999.5200575931076;4005.399190121476;4024.1549274652357;5460.754266058037;5660.3490598581275;5753.510951569122;5786.450287222707;5792.710364481801;4102.384642303678;4150.211459822624;4163.937540936889;4177.958220417757;4223.303154979455;4239.59723826236;4256.425382573375;4259.488861336659;4260.318349064135;4263.189993901149;4498.942748454111;4748.765321016492;4819.7108173509705;4822.662413631012;4825;5488.1461639947;5514.283143191359;5526.944730552724;5531.363893152258;5553.805616803393;1436.4110714606961;1459.2630721485793;1460.7078584283186;1466.6113479927828;1468.919209443491;924.1313165624292;962.4273557233435;965.3773316211004;966.1497881863914;978.6232300564334;4665.043666048452;4697.271922851964;4723.929141062887;4732.881677958078;4774.522547745198;4984.27727979441;4988.800447982113;4998.775055122528;5006.949930500721;5012.448630650625;4580.88547786308;4694.342777429447;4783.497732738082;4798.640101992364;4865.878353041131;2615.2677250369925;2629.4346715456268;2650.231432884442;2660.829235136534;2662.3211081174177;5076.994587138133;5127.692338459629;5134.589232861362;5160.8967820643375;5166.509181627739;5094.949050509447;5097.592192624581;5167.431582525995;5396.973015134978;5834.766609335664;5819.418058194231;5837.357890632027;5874.676892770939;5876.382979787147;5882.823515294548;5682.261306030189;5693.743781529924;5702.657840529581;5705.600607957404;5715.142728590745;5469.124940009579;5625.887482250414;5630.211770352072;5631;5641.251212124254;5807.622504537191;5809.651420914759;5812.360640329645;5841.853953651193;5861.208736820645;3895.0846551061045;4039.636432721069;4052.615001574846;4061.9796901015307;4109.589041095866;5661.518770904355;5662.57530685192;5669.574781891292;5695.857603559944;5711.771529138788;5532.2254884317035;5533.2253484513;5541.224228608079;5544.7782088716;5571.9721401392735;5331.733413329241;5546.417626149197;5564.8330550083565;5616.129499927518;5650.982823091883;5431.619786615057;5476.493964159888;5487.314085739283;5495.642783219078;5502.339719233718;5535.25274087993;5569.220309156641;5584.748686309207;5586.357568879468;5592.008275572549;5290.809567847204;5458.426865179099;5468.343798744176;5502.504774570308;5510.614257001971 21:15:54 INFO - PROCESS | 7724 | |5;yui.html;720.2581341218545;740.400275776621;803.1687203744123;818.8116733151379;826.2811354121912;16541.503754887344;16796.748048779278;16844.410445634374;16846.15769211539;16856.74714879276;14730.63173420665;14880.479183228563;14915.10509369436;14915.179665118414;14916.254187290646;636.6816591704148;744.6239648977258;787.4487858499045;792.0178978067213;794.2295972906271;789.3211837819499;792.5799326357011;793.773774474275;795.645937557787;797.2864286463612;675.6790524500872;840.6889450903175;842.2335674536173;842.2924743215698;842.9199226073513;810.1979040749645;833.4707460762398;838.6016642094986;839.2446797881894;840.5251033166242;605.1769593353036;605.3885575568663;605.5065121925617;605.7516418268533;605.8212827215982;15685.843141568666;15714.135722535257;15726;15728.292226849704;15742;14422.92788536061;14592;14612.26938653063;14637;14800.925995370062;13254.60236192906;13415.530456433979;13477.528286509925;13594.32028398576;13778.311084445737;4418.779061046935;4525.773711314421;4586.564276393738;4702.6002789762915;4703.459102203256;73154.63422682852;73273.26726732771;73326.63336683335;74168.62915685387;74521.6273918627;11198.496067676973;11326.32042077478;11384.544618215345;11398.94300528492;11958.40207989597;20323.390298291073;20441.795582044288;20474.897625511778;20500.69248961237;21245.362639120853;8689.956550217208;8719.084496127942;8752.256058234994;8772.649094036295;8811.559422028873;4403.339499075164;4591.609713174417;4633.675642704979;4710.034442939258;4879.585235254972;3433.1931995980926;3550.2544465661986;3563.6436356364675;3566.6433356664124;3570.321638888603;512.3928145148011;573.7991702903951;581.6335708503616;596.9671668058298;602.1750202222895;606.848287928018;645.7094307561616;707.7593618169847;755.1089714137371;762.6995971867951;10496.475176241158;10507.842382364272;10545.420001899969;10557.736056598647;10832.78334433307;647.601724939159;662.0929326822285;675.3617831149614;689.3864460630043;691.9446444284445;5063.190761758408;5084.898302033938;5122.385313762373;5145.742712864342;5146.65989736543;109616.35575466375;129397.35301323622;130587;131145;133347.333263335;113703.43148284206;114824;114843.42578287054;114965;115016.42491787487;55323.89352212933;56377;63565.046524302175;84749.57625211835;92138;9594.328397012143;10236.53935572886;10414.166866650801;10465.738356541147;10617.41604211745;50983;51514.48485515247;53232;54342.72828635832;55193.724031379585;43560;45484.31773523466;47875;73331.63334183295;75458.62270688612;14144.717105658036;14210.005299628927;14319.212443315717;14568;14618.707625847212;15736.213189340717;15788.763168552252;16021.439249626674;16049.358025678843;16686.58283542921;14644.341004655029;14872;15143.318550665026;15286.312115954586;15287.159206243763;14535.927320363753;14914.477993270184;15059.472918447802;15518.379264829731;15540.456084037456;13386;13573.932130339284;13673.589792306248;14188.929055354658;14278.714425711636;11200.159988001096;11576;11587.246828956091;11782.52869885195;11957.282563046245;10988.230823842254;11657.242279251821;11797.865110142506;12130.454129564367;12164 21:15:54 INFO - PROCESS | 7724 | __end_tp_report 21:15:54 INFO - PROCESS | 7724 | __start_cc_report 21:15:54 INFO - PROCESS | 7724 | _x_x_mozilla_cycle_collect,1084 21:15:54 INFO - PROCESS | 7724 | __end_cc_report 21:15:54 INFO - PROCESS | 7724 | __startTimestamp1467951354120__endTimestamp 21:15:54 INFO - PROCESS | 7724 | 21:15:54 INFO - PROCESS | 7724 | ------- Summary: start ------- 21:15:54 INFO - PROCESS | 7724 | Number of tests: 6 21:15:54 INFO - PROCESS | 7724 | 21:15:54 INFO - PROCESS | 7724 | [#0] dojo.html Cycles:165 Average:5256.39 Median:5452.32 stddev:596.90 (10.9%) stddev-sans-first:570.95 21:15:54 INFO - PROCESS | 7724 | Values: 2962.1 2992.9 3016.2 3022.9 3037.6 5131.8 5170.7 5244.3 5279.9 5317.6 5259.7 5299.2 5337.3 5398.5 5452.3 4739.7 4784.3 4807.1 4819.7 4961.5 4880.6 4880.7 4899.1 4928.1 4949.0 4724.9 4773.6 4782.5 4839.1 4866.1 4766.7 4778.6 4784.0 4820.9 4885.0 4758.2 4770.8 4777.8 4811.8 4824.1 5190.5 5209.1 5288.7 5335.4 5342.9 5660.9 5698.7 5699.4 5701.2 5710.4 5697.0 5724.2 5724.6 5736.4 5739.7 5198.0 5224.1 5279.6 5287.3 5364.4 5791.9 5796.2 5800.8 5813.6 5823.2 5602.8 5609.9 5613.9 5620.9 5620.9 5497.2 5567.6 5614.3 5634.4 5689.0 5590.7 5631.0 5644.4 5652.3 5653.5 5602.9 5621.0 5627.9 5632.0 5647.1 4229.0 4266.8 4287.9 4324.8 4329.1 3877.4 3878.6 3885.0 3916.1 3918.1 5356.4 5401.5 5404.0 5409.0 5411.3 5560.2 5634.2 5704.2 5720.9 5755.1 5406.5 5418.0 5421.3 5421.9 5442.7 4794.0 4962.4 4968.9 4975.0 5015.5 5747.6 5800.9 5804.1 5810.8 5836.0 5660.5 5665.0 5669.7 5671.1 5671.1 5672.9 5709.5 5806.4 5826.5 5827.4 5535.8 5546.3 5549.1 5549.3 5612.7 5632.6 5643.5 5644.8 5650.4 5651.9 5373.5 5473.3 5521.8 5533.4 5534.4 5552.1 5552.5 5558.8 5563.2 5593.0 5445.9 5475.5 5492.2 5501.9 5504.6 5420.5 5494.6 5546.4 5563.3 5605.7 5333.6 5387.2 5396.0 5405.1 5435.8 21:15:54 INFO - PROCESS | 7724 | 21:15:54 INFO - PROCESS | 7724 | [#1] ext.html Cycles:180 Average:70271.06 Median:43542.24 stddev:152995.69 (351.4%) stddev-sans-first:153335.37 21:15:54 INFO - PROCESS | 7724 | Values: 565.7 610.7 617.8 619.8 646.2 30732.7 42752.4 43437.3 43455.0 43463.8 46261.0 46802.5 46837.3 46904.8 46927.8 8910.3 9026.3 9040.5 9044.1 9052.7 8891.5 8953.0 8967.5 8969.1 8980.1 9006.5 9028.2 9036.1 9042.6 9053.2 8933.5 8968.9 8970.7 8972.1 8981.8 8950.6 9023.5 9024.0 9024.1 9025.9 38208.8 38601.6 38733.6 38751.2 38778.2 3455.2 3462.5 3519.5 3614.4 3916.7 31157.7 31819.5 32149.5 32571.1 33960.2 4382.1 4426.3 4448.2 4517.8 4615.6 373598.0 375697.0 376224.0 376859.0 377063.0 53988.5 60016.0 62082.0 63055.4 63093.0 60211.0 65776.0 66067.0 66104.7 66220.0 17328.6 17691.7 17694.4 17698.7 17711.0 12081.6 12600.9 12703.4 12827.6 13071.5 19621.6 19760.3 19919.0 19922.3 19932.3 6923.8 7150.5 7205.2 7209.2 7266.8 929.9 976.2 1001.4 1044.6 1154.1 32867.5 34194.3 34204.5 34390.5 34723.0 1090.1 1099.5 1119.3 1130.5 1130.6 17812.6 17960.9 17971.3 18041.7 18045.4 617406.0 622997.0 623878.0 901977.0 903939.0 58679.7 60019.0 60116.7 60232.4 60257.7 1196.0 1319.6 1340.4 1354.2 1381.8 32949.7 34993.7 35080.0 35262.2 35665.3 52167.0 54980.7 56933.0 57231.4 61297.4 523573.0 524954.0 530041.0 531081.0 532277.0 36308.5 43556.3 44527.6 45145.0 48394.8 49776.0 49792.8 50565.7 51160.0 51746.0 42661.8 42959.1 43528.1 43559.3 44820.3 41746.6 42501.8 42538.1 42698.7 43646.1 41628.6 41918.8 42451.2 42829.0 42894.0 37031.0 38325.3 38385.4 38874.8 38913.4 28740.1 28879.4 29063.0 29247.9 29531.3 21:15:54 INFO - PROCESS | 7724 | 21:15:54 INFO - PROCESS | 7724 | [#2] jquery.html Cycles:180 Average:29032.21 Median:2794.95 stddev:82690.05 (2958.5%) stddev-sans-first:82894.04 21:15:54 INFO - PROCESS | 7724 | Values: 384.0 397.0 397.3 400.8 412.4 18743.6 20525.3 20539.0 20543.1 21382.0 19468.1 19537.8 19932.9 19985.4 19991.7 5625.4 5634.5 5839.2 5843.6 5844.4 5748.2 5802.1 5809.4 5817.9 5821.1 5569.9 5774.5 5778.5 5779.9 5780.8 5513.3 5722.9 5768.9 5776.8 5790.4 5642.6 5677.0 5716.8 5719.5 5722.3 13648.9 13660.6 13825.9 13896.0 14115.4 2327.6 2570.2 2670.6 2766.5 2823.4 10169.4 10290.8 10363.7 11443.4 15202.8 1873.6 1917.2 1953.6 2007.2 2078.6 50897.5 65994.3 68211.3 79313.6 85574.6 10526.6 11052.0 11131.7 11252.4 11273.7 15542.5 15623.4 15637.0 15678.2 15685.1 7056.0 7759.0 7776.1 8065.1 8102.3 7906.3 8066.3 8172.7 8233.3 8460.0 4712.0 4713.0 4722.9 4798.6 4900.7 1905.2 1905.7 1909.8 1936.9 1968.4 787.5 873.9 981.4 1049.2 1106.4 18859.8 20728.8 22080.8 22120.7 22167.4 922.5 938.4 968.6 978.6 998.6 11167.2 11454.8 11538.3 11562.6 11624.8 489014.0 495756.0 508087.0 509026.0 512062.0 86715.0 89282.6 90452.5 99838.0 101358.0 991.4 1012.2 1043.3 1045.2 1049.2 18017.9 18209.0 18457.4 18500.4 18672.5 32783.8 39851.0 41986.2 42829.8 43821.5 47129.4 47593.3 58912.4 60299.4 61765.7 8580.9 8707.3 8711.7 8776.7 8918.9 12917.0 13293.2 14014.0 14283.7 14364.4 12468.6 12488.8 12539.4 12549.0 12632.3 11344.1 12196.9 12244.1 12413.4 12445.4 11980.6 12392.7 12433.0 12651.7 12778.9 8713.0 8768.7 8860.2 9077.1 9179.4 11872.0 12489.3 12647.2 12676.4 12686.7 21:15:54 INFO - PROCESS | 7724 | 21:15:54 INFO - PROCESS | 7724 | [#3] mootools.html Cycles:180 Average:5710.78 Median:449.85 stddev:3241.18 (720.5%) stddev-sans-first:3234.13 21:15:54 INFO - PROCESS | 7724 | Values: 1407.3 1460.7 1549.2 1697.6 1726.4 8023.4 8469.0 8550.3 8554.9 8557.8 7351.5 8017.2 8262.9 8274.7 8406.2 2204.1 2214.4 2227.4 2235.3 2237.4 2227.5 2250.2 2278.2 2278.6 2279.6 1951.7 2024.4 2025.3 2175.9 2243.1 2227.9 2245.2 2246.6 2249.0 2250.2 2224.0 2255.5 2260.7 2261.7 2262.2 8416.4 8456.0 8456.2 8461.9 8479.7 4955.8 5053.5 5083.8 5087.9 5091.0 3236.4 3383.0 3396.1 3402.2 3444.6 1049.6 1088.1 1098.2 1124.1 1130.1 11078.7 11092.7 11093.3 11156.2 11156.9 4256.5 4310.6 4436.8 4436.8 4514.2 10025.7 10029.7 10036.0 10044.7 10046.8 5050.4 5076.8 5080.7 5092.1 5097.1 4783.9 4892.7 4904.7 4908.8 4910.2 3884.7 3994.7 4008.7 4037.8 4096.5 1221.6 1238.7 1281.2 1286.3 1296.6 961.4 965.2 983.3 994.9 996.7 6218.7 6253.9 6259.0 6303.1 6303.4 437.6 437.6 448.3 451.4 453.1 4063.2 4136.2 4202.4 4208.8 4214.5 10423.4 10878.5 11000.7 11046.0 11052.0 10885.5 10909.3 10910.9 10920.5 10921.0 7464.9 8137.7 8156.6 8198.8 8249.8 6290.5 6366.7 6451.6 6498.3 6509.3 9924.3 10173.9 10290.9 10296.0 10298.2 10355.3 10429.5 10459.8 10597.8 10598.3 7594.9 7666.4 7713.2 7773.7 7776.5 8476.4 8546.7 8564.5 8565.4 8573.7 7261.9 7436.3 7485.2 7545.1 7569.3 7381.7 7401.9 7414.4 7416.2 7591.6 7192.4 7199.2 7235.0 7249.4 7280.0 5053.3 5271.6 5272.3 5277.8 5380.4 5130.9 5181.2 5222.7 5409.8 5440.5 21:15:54 INFO - PROCESS | 7724 | 21:15:54 INFO - PROCESS | 7724 | [#4] prototype.html Cycles:180 Average:4579.86 Median:5136.91 stddev:1337.84 (26.0%) stddev-sans-first:1302.94 21:15:54 INFO - PROCESS | 7724 | Values: 326.1 332.6 332.7 341.1 341.5 5280.6 5296.8 5314.6 5324.2 5365.9 5199.5 5213.9 5306.4 5314.9 5322.5 3764.4 3983.5 3991.4 4115.5 4119.2 4134.8 4135.2 4139.5 4140.2 4143.3 4085.0 4098.5 4099.8 4101.8 4117.4 3925.6 4015.6 4105.5 4108.3 4144.8 3661.2 3683.5 3684.9 3693.8 3696.5 5125.3 5139.2 5142.5 5181.2 5219.8 4491.4 4700.8 4769.6 4771.1 4795.6 5448.0 5450.6 5492.9 5496.4 5498.9 3971.4 3989.9 3999.5 4005.4 4024.2 5460.8 5660.3 5753.5 5786.5 5792.7 4102.4 4150.2 4163.9 4178.0 4223.3 4239.6 4256.4 4259.5 4260.3 4263.2 4498.9 4748.8 4819.7 4822.7 4825.0 5488.1 5514.3 5526.9 5531.4 5553.8 1436.4 1459.3 1460.7 1466.6 1468.9 924.1 962.4 965.4 966.1 978.6 4665.0 4697.3 4723.9 4732.9 4774.5 4984.3 4988.8 4998.8 5006.9 5012.4 4580.9 4694.3 4783.5 4798.6 4865.9 2615.3 2629.4 2650.2 2660.8 2662.3 5077.0 5127.7 5134.6 5160.9 5166.5 5094.9 5097.6 5167.4 5397.0 5834.8 5819.4 5837.4 5874.7 5876.4 5882.8 5682.3 5693.7 5702.7 5705.6 5715.1 5469.1 5625.9 5630.2 5631.0 5641.3 5807.6 5809.7 5812.4 5841.9 5861.2 3895.1 4039.6 4052.6 4062.0 4109.6 5661.5 5662.6 5669.6 5695.9 5711.8 5532.2 5533.2 5541.2 5544.8 5572.0 5331.7 5546.4 5564.8 5616.1 5651.0 5431.6 5476.5 5487.3 5495.6 5502.3 5535.3 5569.2 5584.7 5586.4 5592.0 5290.8 5458.4 5468.3 5502.5 5510.6 21:15:54 INFO - PROCESS | 7724 | 21:15:54 INFO - PROCESS | 7724 | [#5] yui.html Cycles:180 Average:20975.43 Median:3556.95 stddev:30744.33 (864.3%) stddev-sans-first:30792.96 21:15:54 INFO - PROCESS | 7724 | Values: 720.3 740.4 803.2 818.8 826.3 16541.5 16796.7 16844.4 16846.2 16856.7 14730.6 14880.5 14915.1 14915.2 14916.3 636.7 744.6 787.4 792.0 794.2 789.3 792.6 793.8 795.6 797.3 675.7 840.7 842.2 842.3 842.9 810.2 833.5 838.6 839.2 840.5 605.2 605.4 605.5 605.8 605.8 15685.8 15714.1 15726.0 15728.3 15742.0 14422.9 14592.0 14612.3 14637.0 14800.9 13254.6 13415.5 13477.5 13594.3 13778.3 4418.8 4525.8 4586.6 4702.6 4703.5 73154.6 73273.3 73326.6 74168.6 74521.6 11198.5 11326.3 11384.5 11398.9 11958.4 20323.4 20441.8 20474.9 20500.7 21245.4 8690.0 8719.1 8752.3 8772.6 8811.6 4403.3 4591.6 4633.7 4710.0 4879.6 3433.2 3550.3 3563.6 3566.6 3570.3 512.4 573.8 581.6 597.0 602.2 606.8 645.7 707.8 755.1 762.7 10496.5 10507.8 10545.4 10557.7 10832.8 647.6 662.1 675.4 689.4 691.9 5063.2 5084.9 5122.4 5145.7 5146.7 109616.4 129397.4 130587.0 131145.0 133347.3 113703.4 114824.0 114843.4 114965.0 115016.4 55323.9 56377.0 63565.0 84749.6 92138.0 9594.3 10236.5 10414.2 10465.7 10617.4 50983.0 51514.5 53232.0 54342.7 55193.7 43560.0 45484.3 47875.0 73331.6 75458.6 14144.7 14210.0 14319.2 14568.0 14618.7 15736.2 15788.8 16021.4 16049.4 16686.6 14644.3 14872.0 15143.3 15286.3 15287.2 14535.9 14914.5 15059.5 15518.4 15540.5 13386.0 13573.9 13673.6 14188.9 14278.7 11200.2 11576.0 11587.2 11782.5 11957.3 10988.2 11657.2 11797.9 12130.5 12164.0 21:15:54 INFO - PROCESS | 7724 | -------- Summary: end -------- 21:15:54 INFO - PROCESS | 7724 | 21:15:54 INFO - TEST-INFO | 7724: exit 0 21:15:54 INFO - TEST-OK | dromaeo_css | took 1113485ms 21:15:54 INFO - TEST-START | kraken 21:15:54 INFO - operating with platform_type : linux_ 21:15:54 INFO - Initialising browser for kraken test... 21:15:54 INFO - TEST-INFO | started process 7914 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEV8FhV/profile http://localhost:42210/getInfo.html) 21:15:59 INFO - PROCESS | 7914 | __metrics Screen width/height:1600/1200 21:15:59 INFO - PROCESS | 7914 | colorDepth:24 21:15:59 INFO - PROCESS | 7914 | Browser inner width/height: 1024/697 21:15:59 INFO - PROCESS | 7914 | __metrics 21:15:59 INFO - PROCESS | 7914 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:16:00 INFO - TEST-INFO | 7914: exit 0 21:16:00 INFO - Browser initialized. 21:16:00 INFO - Running cycle 1/1 for kraken test... 21:16:00 INFO - TEST-INFO | started process 7999 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEV8FhV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:16:12 INFO - PROCESS | 7999 | RSS: Main: 157741056 21:16:12 INFO - PROCESS | 7999 | 21:16:14 INFO - PROCESS | 7999 | Cycle 1(1): loaded http://localhost:42210/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42210/tests/kraken/driver.html?testName=audio-beat-detection) 21:16:15 INFO - PROCESS | 7999 | RSS: Main: 216199168 21:16:15 INFO - PROCESS | 7999 | 21:16:18 INFO - PROCESS | 7999 | Cycle 1(1): loaded http://localhost:42210/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42210/tests/kraken/driver.html?testName=audio-dft) 21:16:19 INFO - PROCESS | 7999 | RSS: Main: 203464704 21:16:19 INFO - PROCESS | 7999 | 21:16:22 INFO - PROCESS | 7999 | Cycle 1(1): loaded http://localhost:42210/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42210/tests/kraken/driver.html?testName=audio-fft) 21:16:22 INFO - PROCESS | 7999 | RSS: Main: 269991936 21:16:22 INFO - PROCESS | 7999 | 21:16:24 INFO - PROCESS | 7999 | Cycle 1(1): loaded http://localhost:42210/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42210/tests/kraken/driver.html?testName=audio-oscillator) 21:16:25 INFO - PROCESS | 7999 | RSS: Main: 180654080 21:16:25 INFO - PROCESS | 7999 | 21:16:27 INFO - PROCESS | 7999 | Cycle 1(1): loaded http://localhost:42210/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42210/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:16:28 INFO - PROCESS | 7999 | RSS: Main: 184565760 21:16:28 INFO - PROCESS | 7999 | 21:16:31 INFO - PROCESS | 7999 | Cycle 1(1): loaded http://localhost:42210/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42210/tests/kraken/driver.html?testName=imaging-darkroom) 21:16:31 INFO - PROCESS | 7999 | RSS: Main: 218955776 21:16:31 INFO - PROCESS | 7999 | 21:16:35 INFO - PROCESS | 7999 | Cycle 1(1): loaded http://localhost:42210/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42210/tests/kraken/driver.html?testName=imaging-desaturate) 21:16:35 INFO - PROCESS | 7999 | RSS: Main: 221188096 21:16:35 INFO - PROCESS | 7999 | 21:16:38 INFO - PROCESS | 7999 | Cycle 1(1): loaded http://localhost:42210/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42210/tests/kraken/driver.html?testName=json-parse-financial) 21:16:39 INFO - PROCESS | 7999 | RSS: Main: 221196288 21:16:39 INFO - PROCESS | 7999 | 21:16:40 INFO - PROCESS | 7999 | Cycle 1(1): loaded http://localhost:42210/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42210/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:16:41 INFO - PROCESS | 7999 | RSS: Main: 205869056 21:16:41 INFO - PROCESS | 7999 | 21:16:43 INFO - PROCESS | 7999 | Cycle 1(1): loaded http://localhost:42210/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42210/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:16:43 INFO - PROCESS | 7999 | RSS: Main: 209764352 21:16:43 INFO - PROCESS | 7999 | 21:16:45 INFO - PROCESS | 7999 | Cycle 1(1): loaded http://localhost:42210/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42210/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:16:46 INFO - PROCESS | 7999 | RSS: Main: 213635072 21:16:46 INFO - PROCESS | 7999 | 21:16:48 INFO - PROCESS | 7999 | Cycle 1(1): loaded http://localhost:42210/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42210/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:16:49 INFO - PROCESS | 7999 | RSS: Main: 230707200 21:16:49 INFO - PROCESS | 7999 | 21:16:52 INFO - PROCESS | 7999 | Cycle 1(1): loaded http://localhost:42210/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42210/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:16:52 INFO - PROCESS | 7999 | RSS: Main: 226185216 21:16:52 INFO - PROCESS | 7999 | 21:16:54 INFO - PROCESS | 7999 | Cycle 1(1): loaded http://localhost:42210/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42210/tests/kraken/driver.html?testName=ai-astar) 21:16:54 INFO - PROCESS | 7999 | RSS: Main: 268922880 21:16:54 INFO - PROCESS | 7999 | 21:16:54 INFO - PROCESS | 7999 | __start_tp_report 21:16:54 INFO - PROCESS | 7999 | _x_x_mozilla_page_load 21:16:54 INFO - PROCESS | 7999 | _x_x_mozilla_page_load_details 21:16:54 INFO - PROCESS | 7999 | |i|pagename|runs| 21:16:54 INFO - PROCESS | 7999 | |0;ai-astar;101;112;112;111;111;110;110;110;109;109 21:16:54 INFO - PROCESS | 7999 | |1;audio-beat-detection;143;117;118;168;119;120;147;125;158;119 21:16:54 INFO - PROCESS | 7999 | |2;audio-dft;159;160;160;162;161;161;159;159;161;160 21:16:54 INFO - PROCESS | 7999 | |3;audio-fft;75;74;74;116;75;75;76;99;97;74 21:16:54 INFO - PROCESS | 7999 | |4;audio-oscillator;84;84;112;84;84;85;129;84;84;132 21:16:54 INFO - PROCESS | 7999 | |5;imaging-gaussian-blur;116;117;117;117;118;117;118;117;117;117 21:16:54 INFO - PROCESS | 7999 | |6;imaging-darkroom;147;145;146;146;145;146;145;145;145;145 21:16:54 INFO - PROCESS | 7999 | |7;imaging-desaturate;94;95;95;95;95;96;94;95;95;95 21:16:54 INFO - PROCESS | 7999 | |8;json-parse-financial;53;54;54;54;54;54;54;53;53;53 21:16:54 INFO - PROCESS | 7999 | |9;json-stringify-tinderbox;61;62;63;63;62;62;62;62;62;63 21:16:54 INFO - PROCESS | 7999 | |10;stanford-crypto-aes;76;79;82;77;74;75;75;79;75;78 21:16:54 INFO - PROCESS | 7999 | |11;stanford-crypto-ccm;119;121;119;118;120;135;123;125;151;129 21:16:54 INFO - PROCESS | 7999 | |12;stanford-crypto-pbkdf2;157;156;156;158;157;156;156;158;158;157 21:16:54 INFO - PROCESS | 7999 | |13;stanford-crypto-sha256-iterative;66;63;63;63;61;64;62;62;63;61 21:16:54 INFO - PROCESS | 7999 | __end_tp_report 21:16:54 INFO - PROCESS | 7999 | __start_cc_report 21:16:54 INFO - PROCESS | 7999 | _x_x_mozilla_cycle_collect,1628 21:16:54 INFO - PROCESS | 7999 | __end_cc_report 21:16:54 INFO - PROCESS | 7999 | __startTimestamp1467951414621__endTimestamp 21:16:54 INFO - PROCESS | 7999 | 21:16:54 INFO - PROCESS | 7999 | ------- Summary: start ------- 21:16:54 INFO - PROCESS | 7999 | Number of tests: 14 21:16:54 INFO - PROCESS | 7999 | 21:16:54 INFO - PROCESS | 7999 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.50 stddev:3.17 (2.9%) stddev-sans-first:1.13 21:16:54 INFO - PROCESS | 7999 | Values: 101.0 112.0 112.0 111.0 111.0 110.0 110.0 110.0 109.0 109.0 21:16:54 INFO - PROCESS | 7999 | 21:16:54 INFO - PROCESS | 7999 | [#1] audio-beat-detection Cycles:10 Average:133.40 Median:134.00 stddev:19.00 (14.2%) stddev-sans-first:19.84 21:16:54 INFO - PROCESS | 7999 | Values: 143.0 117.0 118.0 168.0 119.0 120.0 147.0 125.0 158.0 119.0 21:16:54 INFO - PROCESS | 7999 | 21:16:54 INFO - PROCESS | 7999 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.50 stddev:1.03 (0.6%) stddev-sans-first:1.00 21:16:54 INFO - PROCESS | 7999 | Values: 159.0 160.0 160.0 162.0 161.0 161.0 159.0 159.0 161.0 160.0 21:16:54 INFO - PROCESS | 7999 | 21:16:54 INFO - PROCESS | 7999 | [#3] audio-fft Cycles:10 Average:83.50 Median:75.00 stddev:14.99 (20.0%) stddev-sans-first:15.58 21:16:54 INFO - PROCESS | 7999 | Values: 75.0 74.0 74.0 116.0 75.0 75.0 76.0 99.0 97.0 74.0 21:16:54 INFO - PROCESS | 7999 | 21:16:54 INFO - PROCESS | 7999 | [#4] audio-oscillator Cycles:10 Average:96.20 Median:84.00 stddev:20.07 (23.9%) stddev-sans-first:20.80 21:16:54 INFO - PROCESS | 7999 | Values: 84.0 84.0 112.0 84.0 84.0 85.0 129.0 84.0 84.0 132.0 21:16:54 INFO - PROCESS | 7999 | 21:16:54 INFO - PROCESS | 7999 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 21:16:54 INFO - PROCESS | 7999 | Values: 116.0 117.0 117.0 117.0 118.0 117.0 118.0 117.0 117.0 117.0 21:16:54 INFO - PROCESS | 7999 | 21:16:54 INFO - PROCESS | 7999 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.50 21:16:54 INFO - PROCESS | 7999 | Values: 147.0 145.0 146.0 146.0 145.0 146.0 145.0 145.0 145.0 145.0 21:16:54 INFO - PROCESS | 7999 | 21:16:54 INFO - PROCESS | 7999 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 21:16:54 INFO - PROCESS | 7999 | Values: 94.0 95.0 95.0 95.0 95.0 96.0 94.0 95.0 95.0 95.0 21:16:54 INFO - PROCESS | 7999 | 21:16:54 INFO - PROCESS | 7999 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:54.00 stddev:0.52 (1.0%) stddev-sans-first:0.50 21:16:54 INFO - PROCESS | 7999 | Values: 53.0 54.0 54.0 54.0 54.0 54.0 54.0 53.0 53.0 53.0 21:16:54 INFO - PROCESS | 7999 | 21:16:54 INFO - PROCESS | 7999 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.00 stddev:0.63 (1.0%) stddev-sans-first:0.50 21:16:54 INFO - PROCESS | 7999 | Values: 61.0 62.0 63.0 63.0 62.0 62.0 62.0 62.0 62.0 63.0 21:16:54 INFO - PROCESS | 7999 | 21:16:54 INFO - PROCESS | 7999 | [#10] stanford-crypto-aes Cycles:10 Average:77.00 Median:77.50 stddev:2.49 (3.2%) stddev-sans-first:2.62 21:16:54 INFO - PROCESS | 7999 | Values: 76.0 79.0 82.0 77.0 74.0 75.0 75.0 79.0 75.0 78.0 21:16:54 INFO - PROCESS | 7999 | 21:16:54 INFO - PROCESS | 7999 | [#11] stanford-crypto-ccm Cycles:10 Average:126.00 Median:124.00 stddev:10.26 (8.3%) stddev-sans-first:10.57 21:16:54 INFO - PROCESS | 7999 | Values: 119.0 121.0 119.0 118.0 120.0 135.0 123.0 125.0 151.0 129.0 21:16:54 INFO - PROCESS | 7999 | 21:16:54 INFO - PROCESS | 7999 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.90 Median:157.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 21:16:54 INFO - PROCESS | 7999 | Values: 157.0 156.0 156.0 158.0 157.0 156.0 156.0 158.0 158.0 157.0 21:16:54 INFO - PROCESS | 7999 | 21:16:54 INFO - PROCESS | 7999 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:63.00 stddev:1.48 (2.3%) stddev-sans-first:1.01 21:16:54 INFO - PROCESS | 7999 | Values: 66.0 63.0 63.0 63.0 61.0 64.0 62.0 62.0 63.0 61.0 21:16:54 INFO - PROCESS | 7999 | -------- Summary: end -------- 21:16:54 INFO - PROCESS | 7999 | 21:16:55 INFO - TEST-INFO | 7999: exit 0 21:16:55 INFO - TEST-OK | kraken | took 60775ms 21:16:55 INFO - SUITE-END | took 1174s 21:16:55 INFO - Completed test suite (00:19:34) 21:16:55 INFO - javascript benchmark 21:16:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2962.0965605490323, 2992.91021269362, 3016.215783896186, 3022.8790848366066, 3037.620297462816, 5131.769070391832, 5170.715610641413, 5244.344456942882, 5279.8944021119605, 5317.627766056383, 5259.684418934857, 5299.205119232117, 5337.332833395825, 5398.541124004454, 5452.318460192476, 4739.691920025204, 4784.282357646363, 4807.134715751164, 4819.710817350952, 4961.5286547777905, 4880.567082977591, 4880.65835391521, 4899.1426500362295, 4928.088303663816, 4949.034938187055, 4724.881877953061, 4773.64197685175, 4782.545658162469, 4839.128956787777, 4866.099771542258, 4766.690165139289, 4778.569928706398, 4783.952160478386, 4820.855374338776, 4885.022995400934, 4758.238681810928, 4770.761461926924, 4777.761111944389, 4811.759412029384, 4824.107540105092, 5190.480951904817, 5209.114450543417, 5288.735563221823, 5335.386430560497, 5342.946570534284, 5660.943390566083, 5698.658080515141, 5699.401562835884, 5701.173329867188, 5710.400407957146, 5697.0, 5724.16999535065, 5724.570657200727, 5736.397678243766, 5739.655620662774, 5198.012377648235, 5224.08578498765, 5279.604029697788, 5287.286216360742, 5364.383095943938, 5791.88416231673, 5796.246487956623, 5800.796972105956, 5813.6221145625395, 5823.155642431823, 5602.803901863415, 5609.943900560942, 5613.915791263134, 5620.859478512988, 5620.887582248414, 5497.175423686399, 5567.582431317667, 5614.29821272341, 5634.436556344414, 5689.0, 5590.692511911884, 5631.042722737145, 5644.379118296984, 5652.293463317085, 5653.462921022497, 5602.887942241132, 5620.971895140498, 5627.887442251132, 5632.0, 5647.0964645656495, 4228.957710422918, 4266.807993640294, 4287.935680964788, 4324.783760811947, 4329.1341731653165, 3877.3990031545154, 3878.592747761501, 3885.0287428142965, 3916.118873253495, 3918.059665680273, 5356.3572371315695, 5401.4868587484125, 5403.972980135153, 5408.972955135199, 5411.296531450965, 5560.165975103767, 5634.239377684042, 5704.172894930295, 5720.914186287209, 5755.079187330007, 5406.513413792777, 5417.972910135424, 5421.2952316199435, 5421.945780542223, 5442.673439593637, 4794.0, 4962.354893863775, 4968.925466118011, 4975.0, 5015.498450155028, 5747.597668163188, 5800.854978625568, 5804.129380592861, 5810.82567522975, 5836.037053886146, 5660.54715622741, 5665.0, 5669.659820410789, 5671.064274394678, 5671.149327600893, 5672.914906276492, 5709.543236540983, 5806.390329015392, 5826.504747096545, 5827.388124246893, 5535.778568857361, 5546.278983732089, 5549.056660367828, 5549.250851135045, 5612.747426365905, 5632.605717599892, 5643.492085712305, 5644.774209031592, 5650.350209725934, 5651.915221271766, 5373.516383525345, 5473.288472498709, 5521.779128834802, 5533.391326954113, 5534.446555344433, 5552.139418390156, 5552.52803511706, 5558.833235002957, 5563.193336966198, 5593.049181639212, 5445.863853403696, 5475.479829416199, 5492.231087647812, 5501.889962200814, 5504.614676972574, 5420.512153906167, 5494.560435165097, 5546.362168350692, 5563.304586926634, 5605.719714014364, 5333.599980001593, 5387.218853266333, 5396.0, 5405.081136206933, 5435.83692489226], "value": 5215.524591915962, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.6549504802073, 610.7007566292515, 617.8084793713949, 619.8295468746094, 646.1535388640883, 30732.692673073263, 42752.358714619266, 43437.34843977335, 43455.0, 43463.78268108659, 46261.0, 46802.53197468024, 46837.297440538416, 46904.76547617266, 46927.76536117323, 8910.287177025855, 9026.323025773061, 9040.502772347518, 9044.095590440937, 9052.728418147433, 8891.510966896818, 8953.0, 8967.506787126706, 8969.10308969101, 8980.101989801033, 9006.459612423243, 9028.187463128317, 9036.141566551167, 9042.593083311234, 9053.230475409599, 8933.463992160427, 8968.865467018, 8970.686025989091, 8972.147645973622, 8981.775455613597, 8950.641974321019, 9023.458592484472, 9024.0, 9024.097590240988, 9025.864612030824, 38208.80895595532, 38601.61398386008, 38733.612663873566, 38751.22497550033, 38778.224435511416, 3455.1707590178426, 3462.5498685170764, 3519.5072689823446, 3614.4036234021355, 3916.74541154824, 31157.688423115706, 31819.522707159413, 32149.51775723366, 32571.098772066154, 33960.15099622529, 4382.076319415316, 4426.336049592587, 4448.154850578412, 4517.796699148514, 4615.607673347769, 373598.0, 375697.0, 376224.0, 376859.0, 377063.0, 53988.460115398346, 60016.0, 62082.0, 63055.369446305864, 63093.0, 60211.0, 65776.0, 66067.0, 66104.66947665231, 66220.0, 17328.566785830204, 17691.73462398065, 17694.380696675555, 17698.734518982226, 17711.0, 12081.637550873487, 12600.936995315147, 12703.36483175856, 12827.615171544869, 13071.477140914258, 19621.60756784856, 19760.308389206308, 19919.0, 19922.30271940475, 19932.302369417, 6923.757668481579, 7150.5352152109945, 7205.2434494378385, 7209.2069872314005, 7266.818329541804, 929.9488528131018, 976.1751320134617, 1001.3891526169031, 1044.5560636729513, 1154.1171004181808, 32867.50698739521, 34194.31611367759, 34204.48693269603, 34390.48414273788, 34723.0, 1090.0843291634906, 1099.5272033025876, 1119.2804767637367, 1130.513879032024, 1130.6438471881331, 17812.643747124985, 17960.910195448938, 17971.281148753904, 18041.7293740594, 18045.368412105512, 617406.0, 622997.0, 623878.0, 901977.0, 903939.0, 58679.70660146672, 60019.0, 60116.69941650264, 60232.39767602268, 60257.698711506164, 1196.0, 1319.617310979805, 1340.3633274194679, 1354.2213227394288, 1381.7789153735355, 32949.67050329466, 34993.65006349904, 35080.0, 35262.16484607746, 35665.28669426649, 52167.0, 54980.72509637426, 56933.0, 57231.42768572261, 61297.38702612917, 523573.0, 524954.0, 530041.0, 531081.0, 532277.0, 36308.45537316995, 43556.34665480084, 44527.55472445234, 45145.0, 48394.758026209645, 49776.0, 49792.75103624459, 50565.74717126391, 51160.0, 51746.0, 42661.78669106759, 42959.1408171841, 43528.129437411706, 43559.34660980025, 44820.32769508395, 41746.58253417427, 42501.78749106234, 42538.14923701447, 42698.71251443804, 43646.12707745764, 41628.58371416247, 41918.790406047774, 42451.150976980905, 42829.0, 42894.0, 37031.0, 38325.30426595101, 38385.42421863618, 38874.80562597169, 38913.41629875611, 28740.08320673584, 28879.42241155207, 29063.0, 29247.85376073106, 29531.261718457212], "value": 21159.994440991115, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.9731218814682, 396.9761814291142, 397.3245482679446, 400.78557971485225, 412.38966329831845, 18743.62512749746, 20525.281615143474, 20539.0, 20543.075561599744, 21382.0, 19468.12393442295, 19537.804621953775, 19932.900335498303, 19985.400437986846, 19991.700124498144, 5625.38120806711, 5634.549236061126, 5839.240898683186, 5843.561732870031, 5844.386339434362, 5748.19525266463, 5802.12968054791, 5809.419058094178, 5817.8836423271505, 5821.068629019358, 5569.8607534811545, 5774.480296773289, 5778.451047150535, 5779.884402311972, 5780.797672081478, 5513.283273174502, 5722.885542289152, 5768.884622307552, 5776.768929242825, 5790.392008839074, 5642.633228840113, 5677.0, 5716.771329146829, 5719.456651618131, 5722.284714410699, 13648.863511364858, 13660.590182294547, 13825.861741382558, 13896.027278090538, 14115.435382584787, 2327.627579587275, 2570.1646964736537, 2670.586059160833, 2766.529689952693, 2823.378856651533, 10169.389836609753, 10290.794184116276, 10363.740906477398, 11443.370614616193, 15202.847971520365, 1873.6346412449577, 1917.1564511614984, 1953.6092781443767, 2007.207153174488, 2078.5738923520644, 50897.492810407, 65994.34005659929, 68211.31788682149, 79313.60343198305, 85574.57212713959, 10526.578936842594, 11052.0, 11131.67767032587, 11252.43737813106, 11273.661790146309, 15542.5337239883, 15623.3750649975, 15637.0, 15678.216089195723, 15685.13731744765, 7055.964720176366, 7759.0, 7776.066871975399, 8065.072516660542, 8102.311303539265, 7906.288434040964, 8066.274035336848, 8172.6730930762105, 8233.34133269337, 8460.0, 4712.0, 4712.976435117871, 4722.858314250578, 4798.592119669797, 4900.681455705368, 1905.1902941250191, 1905.6650860993261, 1909.8281154695867, 1936.94189174325, 1968.4389948864505, 787.5353541410595, 873.921347078766, 981.3719219699256, 1049.1606714628267, 1106.363840791548, 18859.81140188608, 20728.792712072685, 22080.779192207872, 22120.668189977165, 22167.44581385446, 922.5018490015451, 938.3525367496405, 968.5835090910836, 978.574320170728, 998.6205242007991, 11167.218294719292, 11454.828177577343, 11538.250013749248, 11562.595309164139, 11624.825627615592, 489014.0, 495756.0, 508087.0, 509026.0, 512062.0, 86715.0, 89282.55358723165, 90452.54773726089, 99838.0, 101358.0, 991.3605724307781, 1012.21047582884, 1043.3062013760764, 1045.2265323660436, 1049.186880167876, 18017.90991045089, 18209.0, 18457.353992610195, 18500.37678975151, 18672.533186670444, 32783.83608081944, 39851.0, 41986.1602767949, 42829.78585107055, 43821.46624868114, 47129.381332613586, 47593.28610070921, 58912.410875890695, 60299.39700602938, 61765.691171543855, 8580.871286930576, 8707.3034157266, 8711.695090671796, 8776.736697899074, 8918.910810891808, 12917.0, 13293.20240785556, 14014.0, 14283.714325713636, 14364.414610148106, 12468.563600273947, 12488.812667809809, 12539.37303134858, 12549.0, 12632.305223212812, 11344.149188810707, 12196.878031219574, 12244.081693873173, 12413.44139513706, 12445.37773111359, 11980.58067967617, 12392.690182745504, 12433.0, 12651.746965060831, 12778.936105319413, 8713.0, 8768.736937891874, 8860.246879015356, 9077.09229077087, 9179.357444978787, 11872.0, 12489.250644961332, 12647.241165530098, 12676.429560669607, 12686.746265074831], "value": 9269.317468218764, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1407.2822860341225, 1460.7297649934762, 1549.2021608871432, 1697.6434948660774, 1726.4130195733449, 8023.398245131617, 8469.0, 8550.273226775724, 8554.871676924851, 8557.828843423127, 7351.522151060178, 8017.19828017198, 8262.91737082629, 8274.710385136521, 8406.159384061591, 2204.1293688992837, 2214.3799736073843, 2227.387468446174, 2235.3182279404773, 2237.3511681612313, 2227.5433536125056, 2250.2124256510174, 2278.2140161644206, 2278.646809744492, 2279.555486680098, 1951.6974868895272, 2024.4230394337617, 2025.250657256817, 2175.869447833127, 2243.1139699818564, 2227.866328020324, 2245.191730976847, 2246.6068438023362, 2248.977510224893, 2250.2124256510256, 2223.9555208895895, 2255.537614788964, 2260.7174103237094, 2261.705978222837, 2262.151693115082, 8416.368772342099, 8455.95772021136, 8456.238938495564, 8461.873071903927, 8479.66081356745, 4955.776990035457, 5053.4946505349535, 5083.822066227664, 5087.949120508822, 5091.032703786269, 3236.433624115794, 3383.035834787074, 3396.117009577503, 3402.1834759657504, 3444.603870554868, 1049.564430761233, 1088.0751361342875, 1098.214776434845, 1124.0726400719439, 1130.107215299912, 11078.667639970734, 11092.722681933015, 11093.278936869077, 11156.16328775345, 11156.888431115665, 4256.489221293403, 4310.590493903074, 4436.778161091933, 4436.844710435119, 4514.232580461329, 10025.749356266006, 10029.749256268506, 10036.046575575454, 10044.748881277881, 10046.799064018678, 5050.393952725696, 5076.82231121909, 5080.695158290514, 5092.134337162691, 5097.108006098918, 4783.856484305476, 4892.657513974059, 4904.705717656881, 4908.828191013297, 4910.238912968495, 3884.7280690351404, 3994.7403418777685, 4008.6793056555407, 4037.818298176589, 4096.549379568245, 1221.5785553983862, 1238.7150955280156, 1281.2056524954587, 1286.2796833773118, 1296.572131196703, 961.4375590279625, 965.1747755668943, 983.2969426859687, 994.8955359687274, 996.7308826616772, 6218.720157592919, 6253.874922501524, 6259.0, 6303.149074874925, 6303.401176888188, 437.5733659681785, 437.6083405352192, 448.2737964497535, 451.43570536828963, 453.12546784705177, 4063.227986682521, 4136.21411931732, 4202.411662367271, 4208.7685177314925, 4214.452121224222, 10423.42671153094, 10878.510467029002, 11000.724981875517, 11046.0, 11052.0, 10885.455727213608, 10909.34543927367, 10910.890891090987, 10920.50857711405, 10921.0, 7464.888026679496, 8137.674493020213, 8156.592170391456, 8198.8360232795, 8249.752507424786, 6290.528210384331, 6366.745330186741, 6451.612903225821, 6498.285188629153, 6509.251436084722, 9924.255680823822, 10173.898261017592, 10290.897091028994, 10296.0, 10298.22763292741, 10355.275130740776, 10429.53067111997, 10459.790804184026, 10597.841032384365, 10598.25812193139, 7594.924050759421, 7666.425018123775, 7713.151553329241, 7773.68905243784, 7776.455648104578, 8476.449030812977, 8546.658133674584, 8564.48613083217, 8565.357598180286, 8573.699920503002, 7261.927380726125, 7436.293552112541, 7485.1766305707415, 7545.132309784445, 7569.280918312751, 7381.704731810667, 7401.888971665322, 7414.406847452299, 7416.221296763762, 7591.620418978919, 7192.42460603161, 7199.2440793718, 7234.96382518084, 7249.42004639617, 7280.017197678246, 5053.343065401475, 5271.630985830955, 5272.340957380327, 5277.822002865829, 5380.408155103014, 5130.947620951649, 5181.248718935658, 5222.660527065728, 5409.78360865561, 5440.483154100354], "value": 4489.870743515365, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.08045312219537, 332.60918420855495, 332.683950247265, 341.0671812592561, 341.45196958881013, 5280.5775537956915, 5296.841094767154, 5314.627976041674, 5324.178185561654, 5365.919511207325, 5199.4800519947985, 5213.895722085556, 5306.416294207644, 5314.92027619586, 5322.547583455411, 3764.3788774852255, 3983.4547252944903, 3991.381335892941, 4115.464989551369, 4119.196756632443, 4134.772587507686, 4135.152293779783, 4139.482564679415, 4140.213359461708, 4143.295639741251, 4084.9591504085024, 4098.52866920305, 4099.7745124018165, 4101.753894766309, 4117.423560701504, 3925.646691797752, 4015.5984401559904, 4105.50733911931, 4108.322126849066, 4144.834206631731, 3661.2311414602964, 3683.4843121962945, 3684.8576941148062, 3693.7968411737343, 3696.482492451059, 5125.333706618116, 5139.229115632647, 5142.537171654569, 5181.248718935771, 5219.8434046978655, 4491.438570178728, 4700.790628404644, 4769.618430525549, 4771.093492236499, 4795.568398844086, 5448.0, 5450.645708029005, 5492.917606235909, 5496.395396506381, 5498.900219956025, 3971.4241434992055, 3989.8803035908677, 3999.5200575931076, 4005.399190121476, 4024.1549274652357, 5460.754266058037, 5660.3490598581275, 5753.510951569122, 5786.450287222707, 5792.710364481801, 4102.384642303678, 4150.211459822624, 4163.937540936889, 4177.958220417757, 4223.303154979455, 4239.59723826236, 4256.425382573375, 4259.488861336659, 4260.318349064135, 4263.189993901149, 4498.942748454111, 4748.765321016492, 4819.7108173509705, 4822.662413631012, 4825.0, 5488.1461639947, 5514.283143191359, 5526.944730552724, 5531.363893152258, 5553.805616803393, 1436.4110714606961, 1459.2630721485793, 1460.7078584283186, 1466.6113479927828, 1468.919209443491, 924.1313165624292, 962.4273557233435, 965.3773316211004, 966.1497881863914, 978.6232300564334, 4665.043666048452, 4697.271922851964, 4723.929141062887, 4732.881677958078, 4774.522547745198, 4984.27727979441, 4988.800447982113, 4998.775055122528, 5006.949930500721, 5012.448630650625, 4580.88547786308, 4694.342777429447, 4783.497732738082, 4798.640101992364, 4865.878353041131, 2615.2677250369925, 2629.4346715456268, 2650.231432884442, 2660.829235136534, 2662.3211081174177, 5076.994587138133, 5127.692338459629, 5134.589232861362, 5160.8967820643375, 5166.509181627739, 5094.949050509447, 5097.592192624581, 5167.431582525995, 5396.973015134978, 5834.766609335664, 5819.418058194231, 5837.357890632027, 5874.676892770939, 5876.382979787147, 5882.823515294548, 5682.261306030189, 5693.743781529924, 5702.657840529581, 5705.600607957404, 5715.142728590745, 5469.124940009579, 5625.887482250414, 5630.211770352072, 5631.0, 5641.251212124254, 5807.622504537191, 5809.651420914759, 5812.360640329645, 5841.853953651193, 5861.208736820645, 3895.0846551061045, 4039.636432721069, 4052.615001574846, 4061.9796901015307, 4109.589041095866, 5661.518770904355, 5662.57530685192, 5669.574781891292, 5695.857603559944, 5711.771529138788, 5532.2254884317035, 5533.2253484513, 5541.224228608079, 5544.7782088716, 5571.9721401392735, 5331.733413329241, 5546.417626149197, 5564.8330550083565, 5616.129499927518, 5650.982823091883, 5431.619786615057, 5476.493964159888, 5487.314085739283, 5495.642783219078, 5502.339719233718, 5535.25274087993, 5569.220309156641, 5584.748686309207, 5586.357568879468, 5592.008275572549, 5290.809567847204, 5458.426865179099, 5468.343798744176, 5502.504774570308, 5510.614257001971], "value": 4159.598495875346, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [720.2581341218545, 740.400275776621, 803.1687203744123, 818.8116733151379, 826.2811354121912, 16541.503754887344, 16796.748048779278, 16844.410445634374, 16846.15769211539, 16856.74714879276, 14730.63173420665, 14880.479183228563, 14915.10509369436, 14915.179665118414, 14916.254187290646, 636.6816591704148, 744.6239648977258, 787.4487858499045, 792.0178978067213, 794.2295972906271, 789.3211837819499, 792.5799326357011, 793.773774474275, 795.645937557787, 797.2864286463612, 675.6790524500872, 840.6889450903175, 842.2335674536173, 842.2924743215698, 842.9199226073513, 810.1979040749645, 833.4707460762398, 838.6016642094986, 839.2446797881894, 840.5251033166242, 605.1769593353036, 605.3885575568663, 605.5065121925617, 605.7516418268533, 605.8212827215982, 15685.843141568666, 15714.135722535257, 15726.0, 15728.292226849704, 15742.0, 14422.92788536061, 14592.0, 14612.26938653063, 14637.0, 14800.925995370062, 13254.60236192906, 13415.530456433979, 13477.528286509925, 13594.32028398576, 13778.311084445737, 4418.779061046935, 4525.773711314421, 4586.564276393738, 4702.6002789762915, 4703.459102203256, 73154.63422682852, 73273.26726732771, 73326.63336683335, 74168.62915685387, 74521.6273918627, 11198.496067676973, 11326.32042077478, 11384.544618215345, 11398.94300528492, 11958.40207989597, 20323.390298291073, 20441.795582044288, 20474.897625511778, 20500.69248961237, 21245.362639120853, 8689.956550217208, 8719.084496127942, 8752.256058234994, 8772.649094036295, 8811.559422028873, 4403.339499075164, 4591.609713174417, 4633.675642704979, 4710.034442939258, 4879.585235254972, 3433.1931995980926, 3550.2544465661986, 3563.6436356364675, 3566.6433356664124, 3570.321638888603, 512.3928145148011, 573.7991702903951, 581.6335708503616, 596.9671668058298, 602.1750202222895, 606.848287928018, 645.7094307561616, 707.7593618169847, 755.1089714137371, 762.6995971867951, 10496.475176241158, 10507.842382364272, 10545.420001899969, 10557.736056598647, 10832.78334433307, 647.601724939159, 662.0929326822285, 675.3617831149614, 689.3864460630043, 691.9446444284445, 5063.190761758408, 5084.898302033938, 5122.385313762373, 5145.742712864342, 5146.65989736543, 109616.35575466375, 129397.35301323622, 130587.0, 131145.0, 133347.333263335, 113703.43148284206, 114824.0, 114843.42578287054, 114965.0, 115016.42491787487, 55323.89352212933, 56377.0, 63565.046524302175, 84749.57625211835, 92138.0, 9594.328397012143, 10236.53935572886, 10414.166866650801, 10465.738356541147, 10617.41604211745, 50983.0, 51514.48485515247, 53232.0, 54342.72828635832, 55193.724031379585, 43560.0, 45484.31773523466, 47875.0, 73331.63334183295, 75458.62270688612, 14144.717105658036, 14210.005299628927, 14319.212443315717, 14568.0, 14618.707625847212, 15736.213189340717, 15788.763168552252, 16021.439249626674, 16049.358025678843, 16686.58283542921, 14644.341004655029, 14872.0, 15143.318550665026, 15286.312115954586, 15287.159206243763, 14535.927320363753, 14914.477993270184, 15059.472918447802, 15518.379264829731, 15540.456084037456, 13386.0, 13573.932130339284, 13673.589792306248, 14188.929055354658, 14278.714425711636, 11200.159988001096, 11576.0, 11587.246828956091, 11782.52869885195, 11957.282563046245, 10988.230823842254, 11657.242279251821, 11797.865110142506, 12130.454129564367, 12164.0], "value": 7689.622996202188, "unit": "score"}], "name": "dromaeo_css", "value": 7264.128565798181, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 112.0, 111.0, 111.0, 110.0, 110.0, 110.0, 109.0, 109.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 117.0, 118.0, 168.0, 119.0, 120.0, 147.0, 125.0, 158.0, 119.0], "value": 133.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 160.0, 162.0, 161.0, 161.0, 159.0, 159.0, 161.0, 160.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 116.0, 75.0, 75.0, 76.0, 99.0, 97.0, 74.0], "value": 83.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 112.0, 84.0, 84.0, 85.0, 129.0, 84.0, 84.0, 132.0], "value": 96.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 96.0, 94.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 53.0, 53.0, 53.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 63.0, 63.0, 62.0, 62.0, 62.0, 62.0, 62.0, 63.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 79.0, 82.0, 77.0, 74.0, 75.0, 75.0, 79.0, 75.0, 78.0], "value": 77.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 121.0, 119.0, 118.0, 120.0, 135.0, 123.0, 125.0, 151.0, 129.0], "value": 126.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 156.0, 156.0, 158.0, 157.0, 156.0, 156.0, 158.0, 158.0, 157.0], "value": 156.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 63.0, 63.0, 61.0, 64.0, 62.0, 62.0, 63.0, 61.0], "value": 62.8, "unit": "score"}], "name": "kraken", "value": 1478.8000000000002, "alertThreshold": 2.0}]} 21:16:55 INFO - Return code: 0 21:16:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:16:55 INFO - # TBPL SUCCESS # 21:16:55 INFO - Running post-action listener: _resource_record_post_action 21:16:55 INFO - ##### 21:16:55 INFO - ##### Finished run-tests step (success) 21:16:55 INFO - ##### 21:16:55 INFO - Running post-run listener: _resource_record_post_run 21:16:55 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 552804352; Read time: 8; Write time: 432592 21:16:55 INFO - TinderboxPrint: CPU usage
13.0% 21:16:55 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 21:16:55 INFO - TinderboxPrint: I/O write bytes / time
552,804,352 / 432,592 21:16:55 INFO - TinderboxPrint: CPU idle
8,275.0 (87.0%) 21:16:55 INFO - TinderboxPrint: CPU user
1,196.3 (12.6%) 21:16:55 INFO - TinderboxPrint: Swap in / out
0 / 0 21:16:55 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256532480; Read time: 0; Write time: 271660 21:16:56 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 296271872; Read time: 0; Write time: 160932 21:16:56 INFO - Running post-run listener: _upload_blobber_files 21:16:56 INFO - Blob upload gear active. 21:16:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:16:56 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 21:16:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:16:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:16:56 INFO - (blobuploader) - INFO - Open directory for files ... 21:16:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:16:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:16:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:16:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:16:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:16:58 INFO - (blobuploader) - INFO - Done attempting. 21:16:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:16:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:16:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:16:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:16:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:16:59 INFO - (blobuploader) - INFO - Done attempting. 21:16:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:16:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:16:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:17:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:17:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:17:02 INFO - (blobuploader) - INFO - Done attempting. 21:17:02 INFO - (blobuploader) - INFO - Iteration through files over. 21:17:02 INFO - Return code: 0 21:17:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:17:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:17:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c0bddfc58a42eaa8334ef50cf536ade96b00d24110ffcd2c7b66bad1844e4f8ff42aeafa1d3df9ff97e49c4b1888428856d3b84d423153afcbceba96e5a1d808", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8df94863f266b5b33d68d26d06c9240db096e2a1ecc9640b7c3a785486679d77b80c697a00b8e40837d0e8cce34f1e184bd13784a86c90999b2479aececd2604", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/61cd344590ed7d235196ecb44e09d3de6953bd861fa06004d069a5a19fe3920bf9b840f022bc2e17433e032207a8f389428afb1eaf884bea183ef5570be72197"} 21:17:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:17:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:17:02 INFO - Contents: 21:17:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c0bddfc58a42eaa8334ef50cf536ade96b00d24110ffcd2c7b66bad1844e4f8ff42aeafa1d3df9ff97e49c4b1888428856d3b84d423153afcbceba96e5a1d808", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8df94863f266b5b33d68d26d06c9240db096e2a1ecc9640b7c3a785486679d77b80c697a00b8e40837d0e8cce34f1e184bd13784a86c90999b2479aececd2604", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/61cd344590ed7d235196ecb44e09d3de6953bd861fa06004d069a5a19fe3920bf9b840f022bc2e17433e032207a8f389428afb1eaf884bea183ef5570be72197"} 21:17:02 INFO - Running post-run listener: copy_logs_to_upload_dir 21:17:02 INFO - Copying logs to upload dir... 21:17:02 INFO - mkdir: /builds/slave/test/build/upload/logs 21:17:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.948258 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-07 21:17:02.513795) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 21:17:02.517754) ========= 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=337fe3f4b1febe37b85fccc40000019e-1467949022.735271-2059095193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c0bddfc58a42eaa8334ef50cf536ade96b00d24110ffcd2c7b66bad1844e4f8ff42aeafa1d3df9ff97e49c4b1888428856d3b84d423153afcbceba96e5a1d808", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8df94863f266b5b33d68d26d06c9240db096e2a1ecc9640b7c3a785486679d77b80c697a00b8e40837d0e8cce34f1e184bd13784a86c90999b2479aececd2604", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/61cd344590ed7d235196ecb44e09d3de6953bd861fa06004d069a5a19fe3920bf9b840f022bc2e17433e032207a8f389428afb1eaf884bea183ef5570be72197"} build_url:https://queue.taskcluster.net/v1/task/Mam8ORD6QrC5eXEtslbDVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011385 build_url: 'https://queue.taskcluster.net/v1/task/Mam8ORD6QrC5eXEtslbDVg/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/Mozilla-Inbound/sha512/c0bddfc58a42eaa8334ef50cf536ade96b00d24110ffcd2c7b66bad1844e4f8ff42aeafa1d3df9ff97e49c4b1888428856d3b84d423153afcbceba96e5a1d808", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8df94863f266b5b33d68d26d06c9240db096e2a1ecc9640b7c3a785486679d77b80c697a00b8e40837d0e8cce34f1e184bd13784a86c90999b2479aececd2604", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/61cd344590ed7d235196ecb44e09d3de6953bd861fa06004d069a5a19fe3920bf9b840f022bc2e17433e032207a8f389428afb1eaf884bea183ef5570be72197"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 21:17:02.545857) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 21:17:02.546410) ========= 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=337fe3f4b1febe37b85fccc40000019e-1467949022.735271-2059095193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004391 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 21:17:02.627079) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 21:17:02.628970) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 21:17:02.629308) ========= ========= Total master_lag: 0.18 =========