builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-043 starttime: 1467293940.83 results: success (0) buildid: 20160630061725 builduid: b74caa2562a74220a1cb97cfc5d3c721 revision: de6b42bae9ddb72f09f04173c306b8fad9fd9a8d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 06:39:00.828055) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 06:39:00.828562) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 06:39:00.828848) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 06:39:00.875072) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 06:39:00.875354) ========= 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=d2a8c569965ab8367867b893000001a1-1467292969.246300-16484698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-30 06:39:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-06-30 06:39:01 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.138283 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 06:39:01.028055) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 06:39:01.028387) ========= 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=d2a8c569965ab8367867b893000001a1-1467292969.246300-16484698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016885 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 06:39:01.077644) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-30 06:39:01.078012) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev de6b42bae9ddb72f09f04173c306b8fad9fd9a8d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev de6b42bae9ddb72f09f04173c306b8fad9fd9a8d --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=d2a8c569965ab8367867b893000001a1-1467292969.246300-16484698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-30 06:39:01,174 truncating revision to first 12 chars 2016-06-30 06:39:01,174 Setting DEBUG logging. 2016-06-30 06:39:01,174 attempt 1/10 2016-06-30 06:39:01,174 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/de6b42bae9dd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-30 06:39:02,366 unpacking tar archive at: fx-team-de6b42bae9dd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.495076 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-30 06:39:02.588421) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 06:39:02.588749) ========= script_repo_revision: de6b42bae9ddb72f09f04173c306b8fad9fd9a8d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 06:39:02.589170) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 06:39:02.589458) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 06:39:02.600854) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-06-30 06:39:02.601135) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d2a8c569965ab8367867b893000001a1-1467292969.246300-16484698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:39:02 INFO - MultiFileLogger online at 20160630 06:39:02 in /builds/slave/test 06:39:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 06:39:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:39:02 INFO - {'append_to_log': False, 06:39:02 INFO - 'base_work_dir': '/builds/slave/test', 06:39:02 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 06:39:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:39:02 INFO - 'branch': 'Fx-Team-Non-PGO', 06:39:02 INFO - 'buildbot_json_path': 'buildprops.json', 06:39:02 INFO - 'config_files': ('talos/linux_config.py',), 06:39:02 INFO - 'default_actions': ('clobber', 06:39:02 INFO - 'read-buildbot-config', 06:39:02 INFO - 'download-and-extract', 06:39:02 INFO - 'populate-webroot', 06:39:02 INFO - 'create-virtualenv', 06:39:02 INFO - 'install', 06:39:02 INFO - 'run-tests'), 06:39:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:39:02 INFO - 'download_minidump_stackwalk': True, 06:39:02 INFO - 'download_symbols': 'ondemand', 06:39:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:39:02 INFO - 'tooltool.py': '/tools/tooltool.py', 06:39:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:39:02 INFO - '/tools/misc-python/virtualenv.py')}, 06:39:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:39:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:39:02 INFO - 'installer_path': 'installer.exe', 06:39:02 INFO - 'log_level': 'info', 06:39:02 INFO - 'log_name': 'talos', 06:39:02 INFO - 'log_to_console': True, 06:39:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:39:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:39:02 INFO - 'opt_config_files': (), 06:39:02 INFO - 'pip_index': False, 06:39:02 INFO - 'sps_profile': False, 06:39:02 INFO - 'sps_profile_interval': 0, 06:39:02 INFO - 'suite': 'dromaeojs', 06:39:02 INFO - 'system_bits': '32', 06:39:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:39:02 INFO - 'title': 'talos-linux64-ix-043', 06:39:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:39:02 INFO - 'use_talos_json': True, 06:39:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:39:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:39:02 INFO - 'work_dir': 'build'} 06:39:02 INFO - ##### 06:39:02 INFO - ##### Running clobber step. 06:39:02 INFO - ##### 06:39:02 INFO - Running pre-action listener: _resource_record_pre_action 06:39:02 INFO - Running main action method: clobber 06:39:02 INFO - rmtree: /builds/slave/test/build 06:39:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:39:03 INFO - Running post-action listener: _resource_record_post_action 06:39:03 INFO - ##### 06:39:03 INFO - ##### Finished clobber step (success) 06:39:03 INFO - ##### 06:39:03 INFO - ##### 06:39:03 INFO - ##### Running read-buildbot-config step. 06:39:03 INFO - ##### 06:39:03 INFO - Running pre-action listener: _resource_record_pre_action 06:39:03 INFO - Running main action method: read_buildbot_config 06:39:03 INFO - Using buildbot properties: 06:39:03 INFO - { 06:39:03 INFO - "project": "", 06:39:03 INFO - "product": "firefox", 06:39:03 INFO - "script_repo_revision": "production", 06:39:03 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:39:03 INFO - "repository": "", 06:39:03 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 06:39:03 INFO - "buildid": "20160630061725", 06:39:03 INFO - "pgo_build": "False", 06:39:03 INFO - "basedir": "/builds/slave/test", 06:39:03 INFO - "buildnumber": 1911, 06:39:03 INFO - "slavename": "talos-linux64-ix-043", 06:39:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:39:03 INFO - "platform": "ubuntu64_hw", 06:39:03 INFO - "scheduler": "tests-fx-team-linux64-talos", 06:39:03 INFO - "branch": "fx-team", 06:39:03 INFO - "repo_path": "integration/fx-team", 06:39:03 INFO - "revision": "de6b42bae9ddb72f09f04173c306b8fad9fd9a8d", 06:39:03 INFO - "stage_platform": "linux64", 06:39:03 INFO - "builduid": "b74caa2562a74220a1cb97cfc5d3c721", 06:39:03 INFO - "slavebuilddir": "test" 06:39:03 INFO - } 06:39:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/WSKjThyKTY226vXbtF4uYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 06:39:03 INFO - Running post-action listener: _resource_record_post_action 06:39:03 INFO - ##### 06:39:03 INFO - ##### Finished read-buildbot-config step (success) 06:39:03 INFO - ##### 06:39:03 INFO - ##### 06:39:03 INFO - ##### Running download-and-extract step. 06:39:03 INFO - ##### 06:39:03 INFO - Running pre-action listener: _resource_record_pre_action 06:39:03 INFO - Running main action method: download_and_extract 06:39:03 INFO - mkdir: /builds/slave/test/build/tests 06:39:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:39:03 INFO - https://queue.taskcluster.net/v1/task/WSKjThyKTY226vXbtF4uYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:39:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WSKjThyKTY226vXbtF4uYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:39:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WSKjThyKTY226vXbtF4uYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:39:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WSKjThyKTY226vXbtF4uYQ/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 06:39:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WSKjThyKTY226vXbtF4uYQ/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 06:39:08 INFO - Downloaded 1361 bytes. 06:39:08 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:39:08 INFO - Using the following test package requirements: 06:39:08 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 06:39:08 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:39:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:39:08 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:39:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:39:08 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:39:08 INFO - u'jsshell-linux-x86_64.zip'], 06:39:08 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:39:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:39:08 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 06:39:08 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:39:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:39:08 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:39:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:39:08 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:39:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:39:08 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:39:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:39:08 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:39:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:39:08 INFO - https://queue.taskcluster.net/v1/task/WSKjThyKTY226vXbtF4uYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:39:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WSKjThyKTY226vXbtF4uYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:39:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WSKjThyKTY226vXbtF4uYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:39:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WSKjThyKTY226vXbtF4uYQ/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 06:39:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WSKjThyKTY226vXbtF4uYQ/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 06:39:11 INFO - Downloaded 22702399 bytes. 06:39:11 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'] 06:39:11 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 06:39:12 INFO - Return code: 0 06:39:12 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 06:39:12 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')]} 06:39:12 INFO - https://queue.taskcluster.net/v1/task/WSKjThyKTY226vXbtF4uYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:39:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WSKjThyKTY226vXbtF4uYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:39:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WSKjThyKTY226vXbtF4uYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:39:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WSKjThyKTY226vXbtF4uYQ/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 06:39:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WSKjThyKTY226vXbtF4uYQ/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 06:39:28 INFO - Downloaded 22702399 bytes. 06:39:28 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'] 06:39:28 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 06:39:29 INFO - Return code: 0 06:39:29 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')]} 06:39:29 INFO - https://queue.taskcluster.net/v1/task/WSKjThyKTY226vXbtF4uYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:39:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WSKjThyKTY226vXbtF4uYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:39:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WSKjThyKTY226vXbtF4uYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:39:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WSKjThyKTY226vXbtF4uYQ/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 06:39:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WSKjThyKTY226vXbtF4uYQ/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 06:39:31 INFO - Downloaded 14405242 bytes. 06:39:31 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'] 06:39:31 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 06:39:31 INFO - Return code: 0 06:39:31 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')]} 06:39:31 INFO - https://queue.taskcluster.net/v1/task/WSKjThyKTY226vXbtF4uYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:39:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WSKjThyKTY226vXbtF4uYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:39:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WSKjThyKTY226vXbtF4uYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:39:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WSKjThyKTY226vXbtF4uYQ/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 06:39:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WSKjThyKTY226vXbtF4uYQ/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 06:39:34 INFO - Downloaded 56465855 bytes. 06:39:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WSKjThyKTY226vXbtF4uYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:39:34 INFO - mkdir: /builds/slave/test/properties 06:39:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:39:34 INFO - Writing to file /builds/slave/test/properties/build_url 06:39:34 INFO - Contents: 06:39:34 INFO - build_url:https://queue.taskcluster.net/v1/task/WSKjThyKTY226vXbtF4uYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:39:35 INFO - Running post-action listener: _resource_record_post_action 06:39:35 INFO - Running post-action listener: set_extra_try_arguments 06:39:35 INFO - ##### 06:39:35 INFO - ##### Finished download-and-extract step (success) 06:39:35 INFO - ##### 06:39:35 INFO - ##### 06:39:35 INFO - ##### Running populate-webroot step. 06:39:35 INFO - ##### 06:39:35 INFO - Running pre-action listener: _resource_record_pre_action 06:39:35 INFO - Running main action method: populate_webroot 06:39:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:39:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:39:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:39:35 INFO - '--tppagecycles', 06:39:35 INFO - '7'], 06:39:35 INFO - 'tests': ['tsvgm']}}, 06:39:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:39:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:39:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:39:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:39:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:39:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:39:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:39:35 INFO - 'talos_options': ['--disable-e10s'], 06:39:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:39:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:39:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:39:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:39:35 INFO - 'talos_options': ['--disable-e10s'], 06:39:35 INFO - 'tests': ['damp', 'tps']}, 06:39:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:39:35 INFO - 'tests': ['damp', 'tps']}, 06:39:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:39:35 INFO - 'tests': ['dromaeo_dom']}, 06:39:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:39:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:39:35 INFO - 'tests': ['basic_compositor_video']}, 06:39:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:39:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:39:35 INFO - 'tests': ['a11yr', 06:39:35 INFO - 'ts_paint', 06:39:35 INFO - 'tpaint', 06:39:35 INFO - 'sessionrestore', 06:39:35 INFO - 'sessionrestore_no_auto_restore', 06:39:35 INFO - 'tabpaint']}, 06:39:35 INFO - 'other-e10s': {'tests': ['a11yr', 06:39:35 INFO - 'ts_paint', 06:39:35 INFO - 'tpaint', 06:39:35 INFO - 'sessionrestore', 06:39:35 INFO - 'sessionrestore_no_auto_restore', 06:39:35 INFO - 'tabpaint']}, 06:39:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:39:35 INFO - 'ts_paint', 06:39:35 INFO - 'tpaint', 06:39:35 INFO - 'sessionrestore', 06:39:35 INFO - 'sessionrestore_no_auto_restore', 06:39:35 INFO - 'tabpaint']}, 06:39:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:39:35 INFO - 'ts_paint', 06:39:35 INFO - 'tpaint', 06:39:35 INFO - 'sessionrestore', 06:39:35 INFO - 'sessionrestore_no_auto_restore', 06:39:35 INFO - 'tabpaint']}, 06:39:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:39:35 INFO - 'tests': ['a11yr', 06:39:35 INFO - 'ts_paint', 06:39:35 INFO - 'tpaint', 06:39:35 INFO - 'sessionrestore', 06:39:35 INFO - 'sessionrestore_no_auto_restore', 06:39:35 INFO - 'tabpaint']}, 06:39:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:39:35 INFO - 'tests': ['a11yr', 06:39:35 INFO - 'ts_paint', 06:39:35 INFO - 'tpaint', 06:39:35 INFO - 'sessionrestore', 06:39:35 INFO - 'sessionrestore_no_auto_restore', 06:39:35 INFO - 'tabpaint']}, 06:39:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:39:35 INFO - 'tests': ['tsvgx', 06:39:35 INFO - 'tsvgr_opacity', 06:39:35 INFO - 'tart', 06:39:35 INFO - 'tscrollx', 06:39:35 INFO - 'cart']}, 06:39:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:39:35 INFO - 'tsvgr_opacity', 06:39:35 INFO - 'tart', 06:39:35 INFO - 'tscrollx', 06:39:35 INFO - 'cart']}, 06:39:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:39:35 INFO - 'talos_options': ['--disable-e10s'], 06:39:35 INFO - 'tests': ['tp5o']}, 06:39:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:39:35 INFO - 'tests': ['tp5o']}, 06:39:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:39:35 INFO - 'talos_options': ['--disable-e10s', 06:39:35 INFO - '--xperf_path', 06:39:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:39:35 INFO - 'tests': ['tp5n']}, 06:39:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:39:35 INFO - 'talos_options': ['--xperf_path', 06:39:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:39:35 INFO - 'tests': ['tp5n']}}, 06:39:35 INFO - 'talos.zip': {'path': '', 06:39:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:39:35 INFO - Running post-action listener: _resource_record_post_action 06:39:35 INFO - ##### 06:39:35 INFO - ##### Finished populate-webroot step (success) 06:39:35 INFO - ##### 06:39:35 INFO - ##### 06:39:35 INFO - ##### Running create-virtualenv step. 06:39:35 INFO - ##### 06:39:35 INFO - Running pre-action listener: _resource_record_pre_action 06:39:35 INFO - Running main action method: create_virtualenv 06:39:35 INFO - Creating virtualenv /builds/slave/test/build/venv 06:39:35 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 06:39:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:39:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:39:35 INFO - Using real prefix '/usr' 06:39:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:39:36 INFO - Installing distribute.............................................................................................................................................................................................done. 06:39:38 INFO - Installing pip.................done. 06:39:38 INFO - Return code: 0 06:39:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:39: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')]} 06:39:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39: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')]} 06:39:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:38 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 0x2377030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2638180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26363b0>, '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 0x26372b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2637740>, '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': 'd2a8c569965ab8367867b893000001a1-1467292969.246300-16484698', '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 06:39:38 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 06:39:38 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 06:39:38 INFO - Using env: {'DISPLAY': ':0', 06:39:38 INFO - 'HOME': '/home/cltbld', 06:39:38 INFO - 'LANG': 'en_US.UTF-8', 06:39:38 INFO - 'LANGUAGE': 'en_US:en', 06:39:38 INFO - 'LOGNAME': 'cltbld', 06:39:38 INFO - 'MAIL': '/var/mail/cltbld', 06:39:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:38 INFO - 'MOZ_NO_REMOTE': '1', 06:39:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:38 INFO - 'NO_EM_RESTART': '1', 06:39:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:38 INFO - 'PWD': '/builds/slave/test', 06:39:38 INFO - 'SHELL': '/bin/bash', 06:39:38 INFO - 'SHLVL': '1', 06:39:38 INFO - 'TERM': 'linux', 06:39:38 INFO - 'TMOUT': '86400', 06:39:38 INFO - 'USER': 'cltbld', 06:39:38 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467292969.246300-16484698', 06:39:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:38 INFO - '_': '/tools/buildbot/bin/python'} 06:39:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:38 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 06:39:38 INFO - Cleaning up... 06:39:38 INFO - Return code: 0 06:39:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:39: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')]} 06:39:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39: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')]} 06:39:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:38 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 0x2377030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2638180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26363b0>, '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 0x26372b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2637740>, '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': 'd2a8c569965ab8367867b893000001a1-1467292969.246300-16484698', '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 06:39:38 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 06:39:38 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 06:39:38 INFO - Using env: {'DISPLAY': ':0', 06:39:38 INFO - 'HOME': '/home/cltbld', 06:39:38 INFO - 'LANG': 'en_US.UTF-8', 06:39:38 INFO - 'LANGUAGE': 'en_US:en', 06:39:38 INFO - 'LOGNAME': 'cltbld', 06:39:38 INFO - 'MAIL': '/var/mail/cltbld', 06:39:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:38 INFO - 'MOZ_NO_REMOTE': '1', 06:39:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:38 INFO - 'NO_EM_RESTART': '1', 06:39:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:38 INFO - 'PWD': '/builds/slave/test', 06:39:38 INFO - 'SHELL': '/bin/bash', 06:39:38 INFO - 'SHLVL': '1', 06:39:38 INFO - 'TERM': 'linux', 06:39:38 INFO - 'TMOUT': '86400', 06:39:38 INFO - 'USER': 'cltbld', 06:39:38 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467292969.246300-16484698', 06:39:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:38 INFO - '_': '/tools/buildbot/bin/python'} 06:39:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:38 INFO - Downloading/unpacking psutil>=3.1.1 06:39:38 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 06:39:38 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 06:39:38 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 06:39:38 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 06:39:38 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 06:39:38 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 06:39:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:39:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:39:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:39:40 INFO - Installing collected packages: psutil 06:39:40 INFO - Running setup.py install for psutil 06:39:40 INFO - building 'psutil._psutil_linux' extension 06:39:40 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 06:39:40 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 06:39:40 INFO - building 'psutil._psutil_posix' extension 06:39:40 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 06:39:41 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 06:39:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:39:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:39:41 INFO - Successfully installed psutil 06:39:41 INFO - Cleaning up... 06:39:41 INFO - Return code: 0 06:39:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:39:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:39:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:39:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:41 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 0x2377030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2638180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26363b0>, '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 0x26372b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2637740>, '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': 'd2a8c569965ab8367867b893000001a1-1467292969.246300-16484698', '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 06:39:41 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 06:39:41 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 06:39:41 INFO - Using env: {'DISPLAY': ':0', 06:39:41 INFO - 'HOME': '/home/cltbld', 06:39:41 INFO - 'LANG': 'en_US.UTF-8', 06:39:41 INFO - 'LANGUAGE': 'en_US:en', 06:39:41 INFO - 'LOGNAME': 'cltbld', 06:39:41 INFO - 'MAIL': '/var/mail/cltbld', 06:39:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:41 INFO - 'MOZ_NO_REMOTE': '1', 06:39:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:41 INFO - 'NO_EM_RESTART': '1', 06:39:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:41 INFO - 'PWD': '/builds/slave/test', 06:39:41 INFO - 'SHELL': '/bin/bash', 06:39:41 INFO - 'SHLVL': '1', 06:39:41 INFO - 'TERM': 'linux', 06:39:41 INFO - 'TMOUT': '86400', 06:39:41 INFO - 'USER': 'cltbld', 06:39:41 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467292969.246300-16484698', 06:39:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:41 INFO - '_': '/tools/buildbot/bin/python'} 06:39:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:39:41 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 06:39:41 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 06:39:41 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 06:39:41 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 06:39:41 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 06:39:41 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 06:39:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:39:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:39:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:39:43 INFO - Installing collected packages: mozsystemmonitor 06:39:43 INFO - Running setup.py install for mozsystemmonitor 06:39:43 INFO - Successfully installed mozsystemmonitor 06:39:43 INFO - Cleaning up... 06:39:43 INFO - Return code: 0 06:39:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:39:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:39:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:43 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 0x2377030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2638180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26363b0>, '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 0x26372b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2637740>, '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': 'd2a8c569965ab8367867b893000001a1-1467292969.246300-16484698', '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 06:39:43 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 06:39:43 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 06:39:43 INFO - Using env: {'DISPLAY': ':0', 06:39:43 INFO - 'HOME': '/home/cltbld', 06:39:43 INFO - 'LANG': 'en_US.UTF-8', 06:39:43 INFO - 'LANGUAGE': 'en_US:en', 06:39:43 INFO - 'LOGNAME': 'cltbld', 06:39:43 INFO - 'MAIL': '/var/mail/cltbld', 06:39:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:43 INFO - 'MOZ_NO_REMOTE': '1', 06:39:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:43 INFO - 'NO_EM_RESTART': '1', 06:39:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:43 INFO - 'PWD': '/builds/slave/test', 06:39:43 INFO - 'SHELL': '/bin/bash', 06:39:43 INFO - 'SHLVL': '1', 06:39:43 INFO - 'TERM': 'linux', 06:39:43 INFO - 'TMOUT': '86400', 06:39:43 INFO - 'USER': 'cltbld', 06:39:43 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467292969.246300-16484698', 06:39:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:43 INFO - '_': '/tools/buildbot/bin/python'} 06:39:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:43 INFO - Downloading/unpacking jsonschema==2.5.1 06:39:43 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 06:39:43 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 06:39:43 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 06:39:43 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 06:39:43 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 06:39:43 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 06:39:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:39:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:39: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 06:39: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 06:39: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 06:39: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 06:39: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 06:39: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 06:39:45 INFO - Downloading functools32-3.2.3-2.tar.gz 06:39:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:39:45 INFO - warning: no files found matching '*.txt' 06:39:45 INFO - no previously-included directories found matching 'build' 06:39:45 INFO - no previously-included directories found matching 'dist' 06:39:45 INFO - no previously-included directories found matching '.git*' 06:39:45 INFO - Installing collected packages: jsonschema, functools32 06:39:45 INFO - Running setup.py install for functools32 06:39:46 INFO - warning: no files found matching '*.txt' 06:39:46 INFO - no previously-included directories found matching 'build' 06:39:46 INFO - no previously-included directories found matching 'dist' 06:39:46 INFO - no previously-included directories found matching '.git*' 06:39:46 INFO - Successfully installed jsonschema functools32 06:39:46 INFO - Cleaning up... 06:39:46 INFO - Return code: 0 06:39:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:39:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:39:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2377030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2638180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26363b0>, '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 0x26372b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2637740>, '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': 'd2a8c569965ab8367867b893000001a1-1467292969.246300-16484698', '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 06:39:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:39:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:39:46 INFO - Using env: {'DISPLAY': ':0', 06:39:46 INFO - 'HOME': '/home/cltbld', 06:39:46 INFO - 'LANG': 'en_US.UTF-8', 06:39:46 INFO - 'LANGUAGE': 'en_US:en', 06:39:46 INFO - 'LOGNAME': 'cltbld', 06:39:46 INFO - 'MAIL': '/var/mail/cltbld', 06:39:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:46 INFO - 'MOZ_NO_REMOTE': '1', 06:39:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:46 INFO - 'NO_EM_RESTART': '1', 06:39:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:46 INFO - 'PWD': '/builds/slave/test', 06:39:46 INFO - 'SHELL': '/bin/bash', 06:39:46 INFO - 'SHLVL': '1', 06:39:46 INFO - 'TERM': 'linux', 06:39:46 INFO - 'TMOUT': '86400', 06:39:46 INFO - 'USER': 'cltbld', 06:39:46 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467292969.246300-16484698', 06:39:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:46 INFO - '_': '/tools/buildbot/bin/python'} 06:39:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:46 INFO - Downloading/unpacking blobuploader==1.2.4 06:39:46 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 06:39:46 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 06:39:46 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 06:39:46 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 06:39:46 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 06:39:46 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 06:39:48 INFO - Downloading blobuploader-1.2.4.tar.gz 06:39:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:39:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:39:48 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 06:39:48 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 06:39:48 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 06:39:48 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 06:39:48 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 06:39:48 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 06:39:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:39:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:39:48 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 06:39:48 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 06:39:48 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 06:39:48 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 06:39:48 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 06:39:48 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 06:39:48 INFO - Downloading docopt-0.6.1.tar.gz 06:39:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:39:48 INFO - Installing collected packages: blobuploader, requests, docopt 06:39:48 INFO - Running setup.py install for blobuploader 06:39:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:39:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:39:49 INFO - Running setup.py install for requests 06:39:49 INFO - Running setup.py install for docopt 06:39:49 INFO - Successfully installed blobuploader requests docopt 06:39:49 INFO - Cleaning up... 06:39:49 INFO - Return code: 0 06:39:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:39:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:39:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:39:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:49 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 0x2377030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2638180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26363b0>, '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 0x26372b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2637740>, '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': 'd2a8c569965ab8367867b893000001a1-1467292969.246300-16484698', '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 06:39:49 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 06:39:49 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 06:39:49 INFO - Using env: {'DISPLAY': ':0', 06:39:49 INFO - 'HOME': '/home/cltbld', 06:39:49 INFO - 'LANG': 'en_US.UTF-8', 06:39:49 INFO - 'LANGUAGE': 'en_US:en', 06:39:49 INFO - 'LOGNAME': 'cltbld', 06:39:49 INFO - 'MAIL': '/var/mail/cltbld', 06:39:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:49 INFO - 'MOZ_NO_REMOTE': '1', 06:39:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:49 INFO - 'NO_EM_RESTART': '1', 06:39:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:49 INFO - 'PWD': '/builds/slave/test', 06:39:49 INFO - 'SHELL': '/bin/bash', 06:39:49 INFO - 'SHLVL': '1', 06:39:49 INFO - 'TERM': 'linux', 06:39:49 INFO - 'TMOUT': '86400', 06:39:49 INFO - 'USER': 'cltbld', 06:39:49 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467292969.246300-16484698', 06:39:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:49 INFO - '_': '/tools/buildbot/bin/python'} 06:39:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:39:49 INFO - Running setup.py (path:/tmp/pip-5OJ1tO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:39:49 INFO - Running setup.py (path:/tmp/pip-RFDQZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:39:49 INFO - Running setup.py (path:/tmp/pip-tbaryG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:39:49 INFO - Running setup.py (path:/tmp/pip-wkeMpa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:39:50 INFO - Running setup.py (path:/tmp/pip-Z3KSFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:39:50 INFO - Running setup.py (path:/tmp/pip-zls5c_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:39:50 INFO - Running setup.py (path:/tmp/pip-CmS0j0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:39:50 INFO - Running setup.py (path:/tmp/pip-6uP60g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:39:50 INFO - Running setup.py (path:/tmp/pip-JiCwwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:39:50 INFO - Running setup.py (path:/tmp/pip-5gSCV4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:39:50 INFO - Running setup.py (path:/tmp/pip-LLy5fC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:39:50 INFO - Running setup.py (path:/tmp/pip-Oq5pxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:39:50 INFO - Running setup.py (path:/tmp/pip-MZZRF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:39:50 INFO - Running setup.py (path:/tmp/pip-Ni7Dcv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:39:50 INFO - Running setup.py (path:/tmp/pip-G3uGgC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:39:50 INFO - Running setup.py (path:/tmp/pip-4VRMaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:39:50 INFO - Running setup.py (path:/tmp/pip-RYu0hC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:39:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:39:50 INFO - Running setup.py install for manifestparser 06:39:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:39:51 INFO - Running setup.py install for mozcrash 06:39:51 INFO - Running setup.py install for mozdebug 06:39:51 INFO - Running setup.py install for mozdevice 06:39:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:39:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:39:51 INFO - Running setup.py install for mozfile 06:39:51 INFO - Running setup.py install for mozhttpd 06:39:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:39:51 INFO - Running setup.py install for mozinfo 06:39:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:39:51 INFO - Running setup.py install for mozInstall 06:39:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:39:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:39:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:39:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:39:51 INFO - Running setup.py install for mozleak 06:39:51 INFO - Running setup.py install for mozlog 06:39:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:39:52 INFO - Running setup.py install for moznetwork 06:39:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:39:52 INFO - Running setup.py install for mozprocess 06:39:52 INFO - Running setup.py install for mozprofile 06:39:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:39:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:39:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:39:52 INFO - Running setup.py install for mozrunner 06:39:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:39:52 INFO - Running setup.py install for mozscreenshot 06:39:52 INFO - Running setup.py install for moztest 06:39:52 INFO - Running setup.py install for mozversion 06:39:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:39:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:39:52 INFO - Cleaning up... 06:39:52 INFO - Return code: 0 06:39:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:39: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')]} 06:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39: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')]} 06:39:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:52 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 0x2377030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2638180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26363b0>, '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 0x26372b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2637740>, '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': 'd2a8c569965ab8367867b893000001a1-1467292969.246300-16484698', '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 06:39:52 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 06:39:52 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 06:39:52 INFO - Using env: {'DISPLAY': ':0', 06:39:52 INFO - 'HOME': '/home/cltbld', 06:39:52 INFO - 'LANG': 'en_US.UTF-8', 06:39:52 INFO - 'LANGUAGE': 'en_US:en', 06:39:52 INFO - 'LOGNAME': 'cltbld', 06:39:52 INFO - 'MAIL': '/var/mail/cltbld', 06:39:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:52 INFO - 'MOZ_NO_REMOTE': '1', 06:39:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:52 INFO - 'NO_EM_RESTART': '1', 06:39:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:52 INFO - 'PWD': '/builds/slave/test', 06:39:52 INFO - 'SHELL': '/bin/bash', 06:39:52 INFO - 'SHLVL': '1', 06:39:52 INFO - 'TERM': 'linux', 06:39:52 INFO - 'TMOUT': '86400', 06:39:52 INFO - 'USER': 'cltbld', 06:39:52 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467292969.246300-16484698', 06:39:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:52 INFO - '_': '/tools/buildbot/bin/python'} 06:39:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:39:53 INFO - Running setup.py (path:/tmp/pip-ixugPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:39:53 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)) 06:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:39:53 INFO - Running setup.py (path:/tmp/pip-Owb4s5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:39:53 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)) 06:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:39:53 INFO - Running setup.py (path:/tmp/pip-DEkJyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:39:53 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)) 06:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:39:53 INFO - Running setup.py (path:/tmp/pip-y16G5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:39:53 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)) 06:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:39:53 INFO - Running setup.py (path:/tmp/pip-_fiiV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:39:53 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)) 06:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:39:53 INFO - Running setup.py (path:/tmp/pip-cywJte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:39:53 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)) 06:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:39:53 INFO - Running setup.py (path:/tmp/pip-DnqN9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:39:53 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)) 06:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:39:53 INFO - Running setup.py (path:/tmp/pip-hSeiNR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:39:53 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)) 06:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:39:53 INFO - Running setup.py (path:/tmp/pip-EvK9xS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:39:53 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)) 06:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:39:53 INFO - Running setup.py (path:/tmp/pip-_Jjetd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:39:53 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)) 06:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:39:53 INFO - Running setup.py (path:/tmp/pip-RwzOrl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:39:53 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)) 06:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:39:53 INFO - Running setup.py (path:/tmp/pip-XVO63R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:39:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:39:53 INFO - Running setup.py (path:/tmp/pip-PQ5DN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:39:53 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)) 06:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:39:53 INFO - Running setup.py (path:/tmp/pip-GLAKrg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:39:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:39:54 INFO - Running setup.py (path:/tmp/pip-CNChOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:39:54 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)) 06:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:39:54 INFO - Running setup.py (path:/tmp/pip-jQTf6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:39:54 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)) 06:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:39:54 INFO - Running setup.py (path:/tmp/pip-tSEpRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:39:54 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)) 06:39:54 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)) 06:39:54 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)) 06:39:54 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)) 06:39:54 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)) 06:39:54 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)) 06:39:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:39: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 06:39: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 06:39: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 06:39: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 06:39: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 06:39: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 06:39:56 INFO - Downloading blessings-1.6.tar.gz 06:39:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:39:56 INFO - Installing collected packages: blessings 06:39:56 INFO - Running setup.py install for blessings 06:39:56 INFO - Successfully installed blessings 06:39:56 INFO - Cleaning up... 06:39:56 INFO - Return code: 0 06:39:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:39:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:39:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:39:56 INFO - Reading from file tmpfile_stdout 06:39:56 INFO - Current package versions: 06:39:56 INFO - argparse == 1.2.1 06:39:56 INFO - blessings == 1.6 06:39:56 INFO - blobuploader == 1.2.4 06:39:56 INFO - docopt == 0.6.1 06:39:56 INFO - functools32 == 3.2.3-2 06:39:56 INFO - jsonschema == 2.5.1 06:39:56 INFO - manifestparser == 1.1 06:39:56 INFO - mozInstall == 1.12 06:39:56 INFO - mozcrash == 0.17 06:39:56 INFO - mozdebug == 0.1 06:39:56 INFO - mozdevice == 0.48 06:39:56 INFO - mozfile == 1.2 06:39:56 INFO - mozhttpd == 0.7 06:39:56 INFO - mozinfo == 0.9 06:39:56 INFO - mozleak == 0.1 06:39:56 INFO - mozlog == 3.2 06:39:56 INFO - moznetwork == 0.27 06:39:56 INFO - mozprocess == 0.22 06:39:56 INFO - mozprofile == 0.28 06:39:56 INFO - mozrunner == 6.11 06:39:56 INFO - mozscreenshot == 0.1 06:39:56 INFO - mozsystemmonitor == 0.3 06:39:56 INFO - moztest == 0.7 06:39:56 INFO - mozversion == 1.4 06:39:56 INFO - psutil == 3.1.1 06:39:56 INFO - requests == 1.2.3 06:39:56 INFO - wsgiref == 0.1.2 06:39:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:39: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')]} 06:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39: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')]} 06:39:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:56 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 0x2377030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2638180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26363b0>, '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 0x26372b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2637740>, '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': 'd2a8c569965ab8367867b893000001a1-1467292969.246300-16484698', '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 06:39:56 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 06:39:56 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 06:39:56 INFO - Using env: {'DISPLAY': ':0', 06:39:56 INFO - 'HOME': '/home/cltbld', 06:39:56 INFO - 'LANG': 'en_US.UTF-8', 06:39:56 INFO - 'LANGUAGE': 'en_US:en', 06:39:56 INFO - 'LOGNAME': 'cltbld', 06:39:56 INFO - 'MAIL': '/var/mail/cltbld', 06:39:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:56 INFO - 'MOZ_NO_REMOTE': '1', 06:39:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:56 INFO - 'NO_EM_RESTART': '1', 06:39:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:56 INFO - 'PWD': '/builds/slave/test', 06:39:56 INFO - 'SHELL': '/bin/bash', 06:39:56 INFO - 'SHLVL': '1', 06:39:56 INFO - 'TERM': 'linux', 06:39:56 INFO - 'TMOUT': '86400', 06:39:56 INFO - 'USER': 'cltbld', 06:39:56 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467292969.246300-16484698', 06:39:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:56 INFO - '_': '/tools/buildbot/bin/python'} 06:39:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:56 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)) 06:39:56 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)) 06:39:56 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)) 06:39:56 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)) 06:39:56 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)) 06:39:56 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)) 06:39:56 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)) 06:39:56 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)) 06:39:56 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)) 06:39:56 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)) 06:39:56 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)) 06:39:56 INFO - Cleaning up... 06:39:56 INFO - Return code: 0 06:39:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:39: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')]} 06:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39: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')]} 06:39:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2377030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2638180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26363b0>, '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 0x26372b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2637740>, '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': 'd2a8c569965ab8367867b893000001a1-1467292969.246300-16484698', '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 06:39:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:39:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:39:56 INFO - Using env: {'DISPLAY': ':0', 06:39:56 INFO - 'HOME': '/home/cltbld', 06:39:56 INFO - 'LANG': 'en_US.UTF-8', 06:39:56 INFO - 'LANGUAGE': 'en_US:en', 06:39:56 INFO - 'LOGNAME': 'cltbld', 06:39:56 INFO - 'MAIL': '/var/mail/cltbld', 06:39:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:56 INFO - 'MOZ_NO_REMOTE': '1', 06:39:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:56 INFO - 'NO_EM_RESTART': '1', 06:39:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:56 INFO - 'PWD': '/builds/slave/test', 06:39:56 INFO - 'SHELL': '/bin/bash', 06:39:56 INFO - 'SHLVL': '1', 06:39:56 INFO - 'TERM': 'linux', 06:39:56 INFO - 'TMOUT': '86400', 06:39:56 INFO - 'USER': 'cltbld', 06:39:56 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467292969.246300-16484698', 06:39:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:56 INFO - '_': '/tools/buildbot/bin/python'} 06:39:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:39:57 INFO - Cleaning up... 06:39:57 INFO - Return code: 0 06:39:57 INFO - Running post-action listener: _resource_record_post_action 06:39:57 INFO - Running post-action listener: _start_resource_monitoring 06:39:57 INFO - Starting resource monitoring. 06:39:57 INFO - ##### 06:39:57 INFO - ##### Finished create-virtualenv step (success) 06:39:57 INFO - ##### 06:39:57 INFO - ##### 06:39:57 INFO - ##### Running install step. 06:39:57 INFO - ##### 06:39:57 INFO - Running pre-action listener: _resource_record_pre_action 06:39:57 INFO - Running main action method: install 06:39:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:39:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:39:57 INFO - Reading from file tmpfile_stdout 06:39:57 INFO - Detecting whether we're running mozinstall >=1.0... 06:39:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:39:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:39:57 INFO - Reading from file tmpfile_stdout 06:39:57 INFO - Output received: 06:39:57 INFO - Usage: mozinstall [options] installer 06:39:57 INFO - Options: 06:39:57 INFO - -h, --help show this help message and exit 06:39:57 INFO - -d DEST, --destination=DEST 06:39:57 INFO - Directory to install application into. [default: 06:39:57 INFO - "/builds/slave/test"] 06:39:57 INFO - --app=APP Application being installed. [default: firefox] 06:39:57 INFO - mkdir: /builds/slave/test/build/application 06:39:57 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'] 06:39:57 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 06:40:13 INFO - Reading from file tmpfile_stdout 06:40:13 INFO - Output received: 06:40:13 INFO - /builds/slave/test/build/application/firefox/firefox 06:40:13 INFO - Running post-action listener: _resource_record_post_action 06:40:13 INFO - ##### 06:40:13 INFO - ##### Finished install step (success) 06:40:13 INFO - ##### 06:40:13 INFO - ##### 06:40:13 INFO - ##### Running run-tests step. 06:40:13 INFO - ##### 06:40:13 INFO - Running pre-action listener: _resource_record_pre_action 06:40:13 INFO - Running main action method: run_tests 06:40:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:40:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:40:13 INFO - Python 2.7.3 06:40:13 INFO - Return code: 0 06:40:13 INFO - grabbing minidump binary from tooltool 06:40:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:13 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 0x26363b0>, '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 0x26372b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2637740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:40:13 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 06:40:13 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 06:40:13 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 06:40:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:40:13 INFO - Return code: 0 06:40:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:40:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:40:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:40:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:40:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:40:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WSKjThyKTY226vXbtF4uYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 06:40:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WSKjThyKTY226vXbtF4uYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --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 06:40:13 INFO - Using env: {'DISPLAY': ':0', 06:40:13 INFO - 'HOME': '/home/cltbld', 06:40:13 INFO - 'LANG': 'en_US.UTF-8', 06:40:13 INFO - 'LANGUAGE': 'en_US:en', 06:40:13 INFO - 'LOGNAME': 'cltbld', 06:40:13 INFO - 'MAIL': '/var/mail/cltbld', 06:40:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:40:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:40:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:40:13 INFO - 'MOZ_NO_REMOTE': '1', 06:40:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:40:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:40:13 INFO - 'NO_EM_RESTART': '1', 06:40:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:40:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:40:13 INFO - 'PWD': '/builds/slave/test', 06:40:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:40:13 INFO - 'SHELL': '/bin/bash', 06:40:13 INFO - 'SHLVL': '1', 06:40:13 INFO - 'TERM': 'linux', 06:40:13 INFO - 'TMOUT': '86400', 06:40:13 INFO - 'USER': 'cltbld', 06:40:13 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467292969.246300-16484698', 06:40:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:40:13 INFO - '_': '/tools/buildbot/bin/python'} 06:40:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WSKjThyKTY226vXbtF4uYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 06:40:13 INFO - mozversion application_buildid: 20160630061725 06:40:13 INFO - mozversion application_changeset: de6b42bae9ddb72f09f04173c306b8fad9fd9a8d 06:40:13 INFO - mozversion application_display_name: Nightly 06:40:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:40:13 INFO - mozversion application_name: Firefox 06:40:13 INFO - mozversion application_remotingname: firefox 06:40:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:40:13 INFO - mozversion application_vendor: Mozilla 06:40:13 INFO - mozversion application_version: 50.0a1 06:40:13 INFO - mozversion platform_buildid: 20160630061725 06:40:13 INFO - mozversion platform_changeset: de6b42bae9ddb72f09f04173c306b8fad9fd9a8d 06:40:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:40:13 INFO - mozversion platform_version: 50.0a1 06:40:13 INFO - using testdate: 1467294013 06:40:13 INFO - actual date: 1467294013 06:40:13 INFO - starting webserver on 'localhost:45941' 06:40:13 INFO - SUITE-START | Running 2 tests 06:40:13 INFO - TEST-START | dromaeo_css 06:40:13 INFO - operating with platform_type : linux_ 06:40:13 INFO - Initialising browser for dromaeo_css test... 06:40:13 INFO - TEST-INFO | started process 16527 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe7RTDw/profile http://localhost:45941/getInfo.html) 06:40:18 INFO - PROCESS | 16527 | __metrics Screen width/height:1600/1200 06:40:18 INFO - PROCESS | 16527 | colorDepth:24 06:40:18 INFO - PROCESS | 16527 | Browser inner width/height: 1024/697 06:40:18 INFO - PROCESS | 16527 | __metrics 06:40:19 INFO - PROCESS | 16527 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:40:20 INFO - TEST-INFO | 16527: exit 0 06:40:20 INFO - Browser initialized. 06:40:20 INFO - Running cycle 1/1 for dromaeo_css test... 06:40:20 INFO - TEST-INFO | started process 16608 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe7RTDw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:40:32 INFO - PROCESS | 16608 | RSS: Main: 158957568 06:40:32 INFO - PROCESS | 16608 | 06:41:23 INFO - PROCESS | 16608 | 1467294083225 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] 06:43:36 INFO - PROCESS | 16608 | Cycle 1(1): loaded http://localhost:45941/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45941/tests/dromaeo/cssquery-ext.html) 06:43:37 INFO - PROCESS | 16608 | RSS: Main: 262504448 06:43:37 INFO - PROCESS | 16608 | 06:46:40 INFO - PROCESS | 16608 | Cycle 1(1): loaded http://localhost:45941/tests/dromaeo/cssquery-ext.html (next: http://localhost:45941/tests/dromaeo/cssquery-jquery.html) 06:46:40 INFO - PROCESS | 16608 | RSS: Main: 237477888 06:46:40 INFO - PROCESS | 16608 | 06:49:43 INFO - PROCESS | 16608 | Cycle 1(1): loaded http://localhost:45941/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45941/tests/dromaeo/cssquery-mootools.html) 06:49:43 INFO - PROCESS | 16608 | RSS: Main: 233156608 06:49:43 INFO - PROCESS | 16608 | 06:52:46 INFO - PROCESS | 16608 | Cycle 1(1): loaded http://localhost:45941/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45941/tests/dromaeo/cssquery-prototype.html) 06:52:46 INFO - PROCESS | 16608 | RSS: Main: 234893312 06:52:46 INFO - PROCESS | 16608 | 06:55:49 INFO - PROCESS | 16608 | Cycle 1(1): loaded http://localhost:45941/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45941/tests/dromaeo/cssquery-yui.html) 06:55:50 INFO - PROCESS | 16608 | RSS: Main: 220545024 06:55:50 INFO - PROCESS | 16608 | 06:58:53 INFO - PROCESS | 16608 | Cycle 1(1): loaded http://localhost:45941/tests/dromaeo/cssquery-yui.html (next: http://localhost:45941/tests/dromaeo/cssquery-dojo.html) 06:58:53 INFO - PROCESS | 16608 | RSS: Main: 271736832 06:58:53 INFO - PROCESS | 16608 | 06:58:53 INFO - PROCESS | 16608 | __start_tp_report 06:58:53 INFO - PROCESS | 16608 | _x_x_mozilla_page_load 06:58:53 INFO - PROCESS | 16608 | _x_x_mozilla_page_load_details 06:58:53 INFO - PROCESS | 16608 | |i|pagename|runs| 06:58:53 INFO - PROCESS | 16608 | |0;dojo.html;2631.5263252614545;2637.9736202637973;2674.5052165349407;2686.0196028449623;2690.4753573053263;4670.813167473297;4716.834910778123;4729.59798417135;4824.782884770189;4854.19905715557;4722.315264286676;4779.522047795219;4807.783649735761;4810.254410566367;4823.13183626947;4354.172707185632;4382.101669157831;4435.624607345502;4491.550844915499;4550.135474259897;4446.0441005183875;4473.88815279619;4500.639948804088;4509.3461448090175;4534.183846907556;4295.441592592974;4296.140771845628;4349.217140914634;4351.412559304516;4409.470863496369;4351.129774045172;4352;4356.586124318216;4410.140022695576;4425.712328698656;4391.758453285068;4395.077033822901;4397.6306723834605;4439.489458712224;4458.910821783546;4671.462781780071;4739;4799.688020278671;4811;4813.422389313269;5096.745162741885;5127.051495473349;5138.74306284688;5149.665271757323;5151.381834179885;5137.717425541594;5161.071007218737;5169.586433085344;5173.430922598511;5174.2238664200295;4662.184117779375;4763.404574428197;4797.95202047982;4799.520047995173;4873.171560834667;5299.5760339172775;5330.853866418739;5336.2529245904825;5337.946620533745;5340.065488539568;4914.262860570871;5073.518015788494;5118.564921981599;5127.974405118991;5129.820456284012;5005.649604527648;5115.130427827278;5115.590752739772;5123.38519377677;5184.818531351385;5093.312402825645;5101.336826212643;5104.285400043997;5108.638260990877;5148.716820574829;4950.950490495049;5040.218766091261;5085.338905942203;5096.439391666913;5097.158968770112;4332.176886391576;4333.155034768253;4348.804303806336;4390.253656878338;4391.055922976575;3794.4118661607495;3810.3903375459795;3814.4278358246484;3831.348670725983;3844.2119365529998;4344.47866256045;4380.299152135707;4493.618042466427;4524.9547504524535;4538;5122.538971492583;5124.410692770379;5129.8717532062;5131.307273518102;5166.715830629351;4469.4860091089295;4508.842190523316;4513.571210734975;4559.430071241095;4562.06477672083;4634.0500197460115;4677.391939047902;4682.204025315705;4682.438107427062;4725.4565724941385;4675.205215113371;4770.475247722678;4912.312276281395;4912.606991440748;4955.207166853286;5056.924146137884;5147.845564633067;5177.145770947752;5188.299579556711;5192.558632516128;4833.685810422311;4838.612910967044;4839.806407743651;4840.34655321527;4891.217405215149;4900.4854490278;5065.062963351792;5070.416902056163;5074.847754567221;5124.1032819257225;5120.18077107661;5164.380274366949;5186;5207.635465517377;5217.686938783685;5040.773165207501;5050.671706339076;5073.923891141562;5074.746262686925;5125.641205115606;4834.5890599298045;4999.950000499948;5048.873778155576;5067.113255180402;5068.467810879952;4978.775955081957;4994.925076123934;5074.543291103819;5078;5079.593632509316;5094.1849304111165;5115.488451154854;5117.513836185556;5120.718360490208;5168.198929165986;4818.277258411266;4897.191963326154;4952.2819191217795;5005.724685142352;5007.499250074963 06:58:53 INFO - PROCESS | 16608 | |1;ext.html;541.4489283823293;582.490320969152;596.1088173181095;602.3165253117538;607.4168797953964;27153.59269610955;30381.544276835837;39870.99999999996;40922.18155636886;40995;41351;41779.16441671165;41794.37308440376;41836.58163418365;41857.37213941786;7572.9621351893165;7855.646495907669;7998.880016799752;8001.5199088054615;8003.51978881266;7515.3987680985665;7777.533347999138;7782.727604533842;10000.849987250198;10284.280100392976;10310;10326.793464130713;10374.740631484197;10388.688339349794;10401.635942742005;10213.080822725953;10250.38497690141;10263.486825658687;10285;10291.58833646657;7457.254274572553;7677.923220767832;7690.115636701795;9807.460589667566;10226.693199204035;38933.41599876004;39241.411378829056;39328.80335598332;39347.21305573873;39363.606363936284;3215.244417561871;3268.2809781847955;3478.9826050869583;3497.283056973314;3618.493410922473;28653.856730716212;29584.11247662552;30003.249918751986;30473.847630761928;30836.53745193824;3325.7505687073326;3364.3103163851597;3386.4243078676686;3509.3332266869215;3514.4201206801104;257320;257383.71308143527;257541;259734;260831;51576.48423515792;52097.21854172191;52194;52289.215661765105;52468.21297680538;54615;54708;54731.45268547343;54804.72597637066;54934;13543;13985.440582376794;14007.599240075911;14013.929930350487;14026.298685065705;9793.314467987173;11735.823962640567;11757.647270581896;11853.525858965717;11874.703132421759;15005;15442.0734755915;15447.922760386125;15959.281832317341;16022.599435014217;5786.855328616818;5788.565857560699;5810.883782324415;5945.494632956161;5988.191594134736;825.3933358981144;858.1932982995963;887.6538150121457;901.4090130918934;930.7207837648679;28396.290092747848;28613.42773144567;28682.569761453597;28937.42125157485;28943;948.4593781544592;964.4599024546277;968.8740463739668;983.0955520920627;1000.7648202672366;14528.200948947699;15139.621509462351;15525;15670.294836732146;16300.755488667679;403798;404605.884852881;404642;405279;408311;50813.729656758136;51120.488795111574;51319.74340128276;51375.743121284155;51528.74235628798;1110.9500072496758;1204.795184818583;1215.7872372334807;1236.5610208376077;1244.8506179258547;27575.448491030467;28800.279993000342;28827;29213.85393073021;29476.410471790874;41507.37738933979;51705.224421634455;52807.207891880884;52901.470985289656;52946;370674;371064;372749;375488;376114;33141;38687.6131238684;39405.2118957625;39786.801065994485;40665.186696265315;42475.787621061696;42783.14433711246;42807.78596107124;43173.78413107914;43801.34297985469;36665.45001824921;37489.25021499609;37774;38276.80861595674;38390.80804596071;37878.24243515059;37920.81039594785;38245.4263186058;38521.807390962866;38777;36305.81847090748;36809.263814724094;37058.25883482369;37440.625593743716;37601.2479750409;31718.682813171574;33179.83410082934;33285.66714332923;33641.49537756887;33818.66181338155;25273;25620.743792561836;25735.525704029715;25736.8713156433;26016 06:58:53 INFO - PROCESS | 16608 | |2;jquery.html;347.2932582195233;361.91133172372764;364.9726270529711;369.918617904061;379.31154953758926;13179.472821087156;16614.584635384123;16842.747358789613;17699.55751106223;18596.628067438643;16811.915940420313;17328.653426931454;17502;17575.91212043941;17599.560010999732;5169.199032014903;5201.739913004353;5354.116570765819;5356.9732151339185;5359.5712343012465;3755.6244375562496;5233.842984710464;5899.970500147493;6214.596051256676;6233.345498722637;6080.756769729205;6275.2469703635625;6291.402316779899;6293.559450838443;6301.6534090625;6185.319614842364;6248.937510624881;6258.49932005443;6260.12358269838;6266.937330626703;3405.4891766235264;5069.315642388304;5372.409035006146;5379.731013449312;5497.202905578709;21653.783462165335;21870.89064554683;21894;21919.232826850985;22202.22292219781;2087.5720477302116;2163.664631982045;2176.7170267865076;2364.2316247219724;2407.1214006887535;13004.674883127904;13457.461701531927;13878.375473103735;13927.651808704763;14186.716265674731;1757.912104394775;1761.1634473625054;1761.903812807687;1786.7051936430603;1807.4396936949456;53938;68958.65520672414;68998.31001689969;71069.28930710678;71682.64158679225;8743;9083;9538.236941044699;9650.71047868565;9859.802803943881;12929.54746583884;13295.66760830987;13372.866271337161;13374.799378009338;13389;7124.287571242834;7231.023811785447;7618.771436856903;7677.270659287359;7835.2948234658015;6684.231313399021;6706.396424321834;6765.763198288037;6786.660666966632;6871.6564171791215;6196.752129914843;6264.436200741955;6309.211348581427;6378;6483.4164925156965;1734.2802736864312;1757.147783325112;1761.603639181174;1779.7330400440037;1806.9819301807076;901.3870568013682;906.8685040669066;936.8828896387952;937.5874615169304;949.0604301741364;17566.91216543909;18079.819201808077;18137.36519221821;18386.81613183878;18497.075146242634;905.7961958559404;911.6171208092617;917.3303488453466;923.7598224461689;959.9424034557949;10074.294799363974;10544.736381590521;10577.524011419504;10618.415987120783;10664.733381665521;387371;389517;390209;425849;435219;85509.57245213859;89597.55201223952;89705.55147224353;91178.54410727904;91191;912.9178373946244;933.1875330895638;937.6765016069445;941.261110028638;942.8679984802134;16304.923769057736;16465.83534164691;16656.750148748022;16726.330946761995;17068.573285667462;27229.727702722717;34877.30245395027;35941.82029089838;38426.23147536978;39645.405318919664;46977;49871.50128498814;51992;52793;52915;7525.510841795266;7528.585927774025;7550.7734767957045;7610.200928902385;7680.385569154342;10055.371646138177;11232.494537745984;11620.941895290469;11856.76286474283;12375.381230938598;9630.374025688308;9881;10232;10370.325928814604;10439;9928.851067233853;9947.05502977216;10253.179745620482;10671;10812.243142979916;9631.807363852824;10220.948895255477;10258.43578603184;10501.369917804956;10635.308704934154;7611.505252158592;7618.733344332922;7696.076470823537;7757.301842834172;7835.294823465915;7471.290227428385;8927.598258078273;9670.468124252951;9728.513574321114;10273.486325683836 06:58:53 INFO - PROCESS | 16608 | |3;mootools.html;1383.7163381506791;1425.1449130521685;1455.461479252676;1683.8063622683394;1708.803487598925;7429.108506979163;7878.92121078789;7933.087694915086;7947.7218297359605;7963.800904977378;6723.36128067834;7432.405407567395;7627.580483073429;7644.426667999895;7825;2202.0421116814196;2219.0125394199586;2222.1777942161425;2224.3327001899447;2225.6995305633695;1917.2906024770855;1992.342526966105;2193.473566344074;2223.855449395792;2229.3646310801423;1960.0787629813965;2133.807957283844;2194.648856183011;2196.0447205465593;2216.789405006522;2148.430665873545;2163.167180635451;2167.674848772681;2168.490404754881;2176;2132.1045161032403;2137.8824164670937;2137.925172618951;2144.967825482619;2160.751513575943;7888.211178882066;7942.722004729864;7953.761387158394;7959.522428654299;7961.203879611992;4456.309272062836;4474.39595654589;4477.753723545204;4505.008898042425;4505.797239124247;2898.0726167626367;2911.6214892063895;3025.6671766105933;3026.546018097281;3040.407120611482;935.6865450074233;950.6815216902346;963.8746962894779;970.0251247496221;976.8485884687884;10831.67504974852;10832.78334433307;10841;10845.457727113613;10859.891401085966;4016.879493615196;4172.290710579209;4275.46556680415;4277.486701595828;4302.139572085595;9088.727338179866;9192.218661413855;9197.218236449842;9201.585928633227;9205.631774728936;4679.27471241958;4688.0858232644305;4696;4698.624110071186;4703.341532185496;4181.163767246502;4267.402563641031;4273.829046838154;4273.893152671208;4278.657707383401;3580.8925732228076;3583.4087375582735;3617.366960781905;3661.41417373219;3682.226732386229;1036.6734478639205;1104.1332553945274;1171.273810237641;1172.6775136837268;1177.140687298277;677.0791723256367;770.1182146442292;811.6591031766673;843.6077224090827;857.8241460500583;4977.776000080005;5178.585713142939;5190.24741412493;5267.71027593486;5361.222622719762;886.7916039730658;897.5108565831507;897.6364572348209;904.0913881549133;906.8775715278485;3654.9634503654624;3661.853525858989;3676.980713195519;3684.244729830378;3709.8330575124182;8812.8678069829;9201.17189452939;9272.768180795534;9311.860322095174;9327.486988215578;9106.089391060841;9196.402233854778;9198.172164505228;9213.30900182489;9227.169554740105;6398.776042838572;6606.7026983785845;6630.905900526455;6758.662066896635;6793.354631310018;5070.619703522177;5153.5361817436615;5214.661047031931;5320.308359913187;5398.433164517826;8436.578171091543;8467.53428561435;8499.74500764978;8538.743837684879;8550;8519.190676885686;8566.571671416528;8596.527191004305;8811.64753409882;8814.691485797966;6509.837254068686;6549.967250163719;6551.80344589663;6565;6579.934200657932;7158.713651454092;7192.029076074872;7216.639168041682;7217.350438460564;7224;6444.581102228341;6607;6700.262971073081;6700.262971073081;6931.584104953719;6551.868962620816;6721.495887808336;6783.796486105425;6836.28219036994;7013.509054366145;6116.052011937979;6129.908051379144;6170.580766423658;6176.66028368444;6186.381361863778;4531.909361812811;4540.182767101954;4557.339185817971;4629.768511574341;4688.742119183477;4597.057603191404;4715.905681886412;4727.267273572602;4728.432588089451;4771.71369717818 06:58:53 INFO - PROCESS | 16608 | |4;prototype.html;291.8117814009964;294.1000538352641;299.11462072266085;303.03936521227706;304.0953164336099;4737.242041273397;4891.902161956758;4938.555530002299;4968.155413579691;5024.7236401997925;4714.717116972975;4847.1517484440255;4851.951480485194;4857.344258525098;4866.197077482211;3835.2904712628115;3838.923221535568;3841.0781412460947;3841.1165431950667;3851.845926162964;3631.6368363163606;3651.908702282451;3840.790151102394;3842.193139440707;3847.6921846252235;3801.9049523761987;3802.372608519605;3803.8858834235016;3811.866584669537;3823.4647149399107;3790.4882840816413;3792.9000589828916;3798.753081049723;3799.411091280856;3805.8858234253016;3358.7999860091677;3370.612379576331;3371.6291207967106;3374.5444365010653;3388.8305584720665;4635.930461043087;4729.196036673739;4751.40607424072;4780.4741478437345;4826.469088400273;4310.547392523803;4324.870253892388;4333.826646934119;4337.592636086971;4345.9348109778375;5042.873928151789;5047.116754567936;5053.797848086109;5062.341895553592;5068.645194836363;3559.982200088983;3573.4639804029343;3645;3652.3425783358985;3660.8468332475186;5213.53078222958;5266.920996185098;5287.995280896617;5303.071962406602;5319.3616765987945;3701.333759923186;3707.647773461517;3716.2939041582013;3725;3757.981210093932;3792.58281589025;3801.676857467091;3805;3814.7520411173186;3824.6366595173413;4218.451601291874;4326.134773045404;4326.956730432718;4331.436913201263;4388;5056.924146137811;5082.313887625197;5082.567981721521;5088.440271570124;5092.668976516515;1262.8042653388738;1286.3889652415028;1315.1648703073427;1332.380443093966;1337.4249072898747;866.6663334616092;869.5304535550858;877.5919197573031;881.9382643215042;896.4262871762078;4133.028738246509;4140.716377922854;4157.48031496063;4158.480189976253;4158.91682166355;4695.718256904528;4712.09160290083;4714.4106986626675;4729.597984171315;4730.243161094278;4105.7331273467125;4105.938410923838;4109.547949725527;4120.443740095108;4125.876223713293;2455.5699936263863;2468.4816188600234;2518.0934863449143;2522.1928982725717;2522.243327001892;4434.822607095744;4438.800253988514;4444.266695995125;4446.466424029137;4458.487273963471;4765.451973023078;4772.665913386029;4792.155020317134;4800.759962001886;4821.373221481185;4262.57203836712;4420.336949457607;4447.666425018137;4465.218586747371;4484.730916144977;4686.5782079613;4693.3104082530945;4726.574608285133;4733.290006499053;4758.357621721162;4561.384213131185;4581.198290299251;4583.2958554453035;4592.058627981322;4598.436531579279;4144.321549772347;4343.740315308525;4357.934630980474;4442.200403927324;4455.576720211575;3454.740894432877;3492.4586689063235;3494.4583589543663;3518.2435776308216;3524.22467057247;4667.766611669335;4670.299455081765;4701.694389864648;4702.27114797207;5058.192703049843;4934.728589927445;5123.410807757006;5131.512506311894;5140.12617854973;5151.072806894795;5091.389033316026;5101.540861322499;5132.538071573576;5162.315595890192;5172.844814655567;4839.733814640229;5023.69857808518;5053.862880851779;5062.82280120194;5075.11185542536;5090;5134.229865520202;5139.301866520107;5144.717040562805;5146.150885103916;5022.924656130088;5063.924041139459;5107.463716309734;5114.5652619527755;5121.257417674342 06:58:53 INFO - PROCESS | 16608 | |5;yui.html;636.964966926819;669.819148829816;692.5533031194876;734.7979305690934;746.5896673967751;13044.28256445895;13951.302434878253;14006.509772157977;14014;14031.508897188587;12981.675458113528;13389.866101338983;13447;13466.192028478297;13513.324333783321;631.7094136697125;768.5657603454031;775.4145620056863;792.6353877216487;795.7493389582263;797.1868693932186;805.8186907945724;805.87508936115;806.3347738116048;806.6410447350931;853.4068822168596;854.995725021374;855.0338117926765;855.6106971328031;855.9443636163661;668.5787953589256;811.3347055414563;834.1033389106734;846.9618867150962;847.1824689174945;612.0085461552313;612.1124369664005;612.2775125352083;612.4518555892496;612.604869858943;13490;13504.122232054886;13519.864801352058;13532.458701651922;13540.796888046687;12285.69285767854;12690.87309126906;12722.809157862639;13037.890185216615;13095.083344165912;11677;11746.823797643043;11816.468258928282;11957.162998590102;12206.816897746541;4192.329227323644;4213.136307057046;4232.132412855357;4267.445232119836;4358.193734159191;58860.70569647167;59329.40670593282;59552.106718399256;60376.69811650958;60736.39263607396;10442;10472.371657700562;10597.20520960931;10654.680359589225;11042.33745975244;18825.623487530174;18843.24627014904;18886.3389781357;18903.43289701311;18922.90538547326;6819.69825225309;6951.617661028692;6968.407685346701;7039.436845052383;7202.207757146814;3858.440526123696;3898.2398432305995;3951.3677811550588;3982.342913419311;4066.755994640331;2856.9142925712263;2947.926301842428;2949.7787665925143;2950.4836653585535;2951.8671659775364;476.4092525268642;492.29355874320464;499.557891266232;501.57115666104954;505.57784250151536;495.2768957322278;497.2292945933788;528.3501293409051;602.599271484458;607.5777334752305;7725.845483090419;7937.801554961172;8041.839163216703;8145.674173033012;8147.959260203661;497.8008796481436;521.5644936478008;531.232369226464;613.4816080412045;640.0271587187449;3769.227308401771;3778.7165962552917;3921.1961547882615;3924.372100463969;3988.700847436454;84521.57739211388;84757.57621211978;91491.54254228686;98551;98616.50691746495;49573.25640115401;50677;51019.744901276;60967.39032609706;72010.63994680098;47245.346412875384;52559.73720131375;71961.28038719755;72364;75488;7966.322862556516;7976.20237976221;8100.756977290455;8115.269625733712;8236.794080148044;31020.68979310178;31566.684333156376;38686.613133868304;38706.908597321104;41102.1779564413;40659.390109148975;51261;57104.1434378493;58047;59471.40528594832;11505.23123502991;11954.222975506564;12341.814872776737;12794.744105118032;12988.090833641932;13436.798448023092;13641.795373069213;13828.585142445743;13853.479341565575;14041.929790350983;11067.335959842436;11201.271917325348;11241.49413276388;11540;11862.584809531625;11689.649310520697;11907.583234586747;11956.641300760992;12041.808920635864;12090.637280881587;11251.831222531833;11494.367809770543;11743.412829358327;11952;12250.75498490043;10133.64532241368;10238;10317.9484102579;10385;10438.164946804389;9915.678247787073;10096.708719704033;10144.898551014396;10155.695329140137;10217.540210690388 06:58:53 INFO - PROCESS | 16608 | __end_tp_report 06:58:53 INFO - PROCESS | 16608 | __start_cc_report 06:58:53 INFO - PROCESS | 16608 | _x_x_mozilla_cycle_collect,1016 06:58:53 INFO - PROCESS | 16608 | __end_cc_report 06:58:53 INFO - PROCESS | 16608 | __startTimestamp1467295133382__endTimestamp 06:58:53 INFO - PROCESS | 16608 | 06:58:53 INFO - PROCESS | 16608 | ------- Summary: start ------- 06:58:53 INFO - PROCESS | 16608 | Number of tests: 6 06:58:53 INFO - PROCESS | 16608 | 06:58:53 INFO - PROCESS | 16608 | [#0] dojo.html Cycles:165 Average:4758.30 Median:4873.17 stddev:503.45 (10.3%) stddev-sans-first:476.55 06:58:53 INFO - PROCESS | 16608 | Values: 2631.5 2638.0 2674.5 2686.0 2690.5 4670.8 4716.8 4729.6 4824.8 4854.2 4722.3 4779.5 4807.8 4810.3 4823.1 4354.2 4382.1 4435.6 4491.6 4550.1 4446.0 4473.9 4500.6 4509.3 4534.2 4295.4 4296.1 4349.2 4351.4 4409.5 4351.1 4352.0 4356.6 4410.1 4425.7 4391.8 4395.1 4397.6 4439.5 4458.9 4671.5 4739.0 4799.7 4811.0 4813.4 5096.7 5127.1 5138.7 5149.7 5151.4 5137.7 5161.1 5169.6 5173.4 5174.2 4662.2 4763.4 4798.0 4799.5 4873.2 5299.6 5330.9 5336.3 5337.9 5340.1 4914.3 5073.5 5118.6 5128.0 5129.8 5005.6 5115.1 5115.6 5123.4 5184.8 5093.3 5101.3 5104.3 5108.6 5148.7 4951.0 5040.2 5085.3 5096.4 5097.2 4332.2 4333.2 4348.8 4390.3 4391.1 3794.4 3810.4 3814.4 3831.3 3844.2 4344.5 4380.3 4493.6 4525.0 4538.0 5122.5 5124.4 5129.9 5131.3 5166.7 4469.5 4508.8 4513.6 4559.4 4562.1 4634.1 4677.4 4682.2 4682.4 4725.5 4675.2 4770.5 4912.3 4912.6 4955.2 5056.9 5147.8 5177.1 5188.3 5192.6 4833.7 4838.6 4839.8 4840.3 4891.2 4900.5 5065.1 5070.4 5074.8 5124.1 5120.2 5164.4 5186.0 5207.6 5217.7 5040.8 5050.7 5073.9 5074.7 5125.6 4834.6 5000.0 5048.9 5067.1 5068.5 4978.8 4994.9 5074.5 5078.0 5079.6 5094.2 5115.5 5117.5 5120.7 5168.2 4818.3 4897.2 4952.3 5005.7 5007.5 06:58:53 INFO - PROCESS | 16608 | 06:58:53 INFO - PROCESS | 16608 | [#1] ext.html Cycles:180 Average:50595.34 Median:206544.62 stddev:92599.82 (44.8%) stddev-sans-first:92783.33 06:58:53 INFO - PROCESS | 16608 | Values: 541.4 582.5 596.1 602.3 607.4 27153.6 30381.5 39871.0 40922.2 40995.0 41351.0 41779.2 41794.4 41836.6 41857.4 7573.0 7855.6 7998.9 8001.5 8003.5 7515.4 7777.5 7782.7 10000.8 10284.3 10310.0 10326.8 10374.7 10388.7 10401.6 10213.1 10250.4 10263.5 10285.0 10291.6 7457.3 7677.9 7690.1 9807.5 10226.7 38933.4 39241.4 39328.8 39347.2 39363.6 3215.2 3268.3 3479.0 3497.3 3618.5 28653.9 29584.1 30003.2 30473.8 30836.5 3325.8 3364.3 3386.4 3509.3 3514.4 257320.0 257383.7 257541.0 259734.0 260831.0 51576.5 52097.2 52194.0 52289.2 52468.2 54615.0 54708.0 54731.5 54804.7 54934.0 13543.0 13985.4 14007.6 14013.9 14026.3 9793.3 11735.8 11757.6 11853.5 11874.7 15005.0 15442.1 15447.9 15959.3 16022.6 5786.9 5788.6 5810.9 5945.5 5988.2 825.4 858.2 887.7 901.4 930.7 28396.3 28613.4 28682.6 28937.4 28943.0 948.5 964.5 968.9 983.1 1000.8 14528.2 15139.6 15525.0 15670.3 16300.8 403798.0 404605.9 404642.0 405279.0 408311.0 50813.7 51120.5 51319.7 51375.7 51528.7 1111.0 1204.8 1215.8 1236.6 1244.9 27575.4 28800.3 28827.0 29213.9 29476.4 41507.4 51705.2 52807.2 52901.5 52946.0 370674.0 371064.0 372749.0 375488.0 376114.0 33141.0 38687.6 39405.2 39786.8 40665.2 42475.8 42783.1 42807.8 43173.8 43801.3 36665.5 37489.3 37774.0 38276.8 38390.8 37878.2 37920.8 38245.4 38521.8 38777.0 36305.8 36809.3 37058.3 37440.6 37601.2 31718.7 33179.8 33285.7 33641.5 33818.7 25273.0 25620.7 25735.5 25736.9 26016.0 06:58:53 INFO - PROCESS | 16608 | 06:58:53 INFO - PROCESS | 16608 | [#2] jquery.html Cycles:180 Average:25275.61 Median:5119.26 stddev:67173.39 (1312.2%) stddev-sans-first:67335.75 06:58:53 INFO - PROCESS | 16608 | Values: 347.3 361.9 365.0 369.9 379.3 13179.5 16614.6 16842.7 17699.6 18596.6 16811.9 17328.7 17502.0 17575.9 17599.6 5169.2 5201.7 5354.1 5357.0 5359.6 3755.6 5233.8 5900.0 6214.6 6233.3 6080.8 6275.2 6291.4 6293.6 6301.7 6185.3 6248.9 6258.5 6260.1 6266.9 3405.5 5069.3 5372.4 5379.7 5497.2 21653.8 21870.9 21894.0 21919.2 22202.2 2087.6 2163.7 2176.7 2364.2 2407.1 13004.7 13457.5 13878.4 13927.7 14186.7 1757.9 1761.2 1761.9 1786.7 1807.4 53938.0 68958.7 68998.3 71069.3 71682.6 8743.0 9083.0 9538.2 9650.7 9859.8 12929.5 13295.7 13372.9 13374.8 13389.0 7124.3 7231.0 7618.8 7677.3 7835.3 6684.2 6706.4 6765.8 6786.7 6871.7 6196.8 6264.4 6309.2 6378.0 6483.4 1734.3 1757.1 1761.6 1779.7 1807.0 901.4 906.9 936.9 937.6 949.1 17566.9 18079.8 18137.4 18386.8 18497.1 905.8 911.6 917.3 923.8 959.9 10074.3 10544.7 10577.5 10618.4 10664.7 387371.0 389517.0 390209.0 425849.0 435219.0 85509.6 89597.6 89705.6 91178.5 91191.0 912.9 933.2 937.7 941.3 942.9 16304.9 16465.8 16656.8 16726.3 17068.6 27229.7 34877.3 35941.8 38426.2 39645.4 46977.0 49871.5 51992.0 52793.0 52915.0 7525.5 7528.6 7550.8 7610.2 7680.4 10055.4 11232.5 11620.9 11856.8 12375.4 9630.4 9881.0 10232.0 10370.3 10439.0 9928.9 9947.1 10253.2 10671.0 10812.2 9631.8 10220.9 10258.4 10501.4 10635.3 7611.5 7618.7 7696.1 7757.3 7835.3 7471.3 8927.6 9670.5 9728.5 10273.5 06:58:53 INFO - PROCESS | 16608 | 06:58:53 INFO - PROCESS | 16608 | [#3] mootools.html Cycles:180 Average:5069.99 Median:5241.19 stddev:2798.48 (53.4%) stddev-sans-first:2792.62 06:58:53 INFO - PROCESS | 16608 | Values: 1383.7 1425.1 1455.5 1683.8 1708.8 7429.1 7878.9 7933.1 7947.7 7963.8 6723.4 7432.4 7627.6 7644.4 7825.0 2202.0 2219.0 2222.2 2224.3 2225.7 1917.3 1992.3 2193.5 2223.9 2229.4 1960.1 2133.8 2194.6 2196.0 2216.8 2148.4 2163.2 2167.7 2168.5 2176.0 2132.1 2137.9 2137.9 2145.0 2160.8 7888.2 7942.7 7953.8 7959.5 7961.2 4456.3 4474.4 4477.8 4505.0 4505.8 2898.1 2911.6 3025.7 3026.5 3040.4 935.7 950.7 963.9 970.0 976.8 10831.7 10832.8 10841.0 10845.5 10859.9 4016.9 4172.3 4275.5 4277.5 4302.1 9088.7 9192.2 9197.2 9201.6 9205.6 4679.3 4688.1 4696.0 4698.6 4703.3 4181.2 4267.4 4273.8 4273.9 4278.7 3580.9 3583.4 3617.4 3661.4 3682.2 1036.7 1104.1 1171.3 1172.7 1177.1 677.1 770.1 811.7 843.6 857.8 4977.8 5178.6 5190.2 5267.7 5361.2 886.8 897.5 897.6 904.1 906.9 3655.0 3661.9 3677.0 3684.2 3709.8 8812.9 9201.2 9272.8 9311.9 9327.5 9106.1 9196.4 9198.2 9213.3 9227.2 6398.8 6606.7 6630.9 6758.7 6793.4 5070.6 5153.5 5214.7 5320.3 5398.4 8436.6 8467.5 8499.7 8538.7 8550.0 8519.2 8566.6 8596.5 8811.6 8814.7 6509.8 6550.0 6551.8 6565.0 6579.9 7158.7 7192.0 7216.6 7217.4 7224.0 6444.6 6607.0 6700.3 6700.3 6931.6 6551.9 6721.5 6783.8 6836.3 7013.5 6116.1 6129.9 6170.6 6176.7 6186.4 4531.9 4540.2 4557.3 4629.8 4688.7 4597.1 4715.9 4727.3 4728.4 4771.7 06:58:53 INFO - PROCESS | 16608 | 06:58:53 INFO - PROCESS | 16608 | [#4] prototype.html Cycles:180 Average:4090.41 Median:4451.62 stddev:1170.95 (26.3%) stddev-sans-first:1138.99 06:58:53 INFO - PROCESS | 16608 | Values: 291.8 294.1 299.1 303.0 304.1 4737.2 4891.9 4938.6 4968.2 5024.7 4714.7 4847.2 4852.0 4857.3 4866.2 3835.3 3838.9 3841.1 3841.1 3851.8 3631.6 3651.9 3840.8 3842.2 3847.7 3801.9 3802.4 3803.9 3811.9 3823.5 3790.5 3792.9 3798.8 3799.4 3805.9 3358.8 3370.6 3371.6 3374.5 3388.8 4635.9 4729.2 4751.4 4780.5 4826.5 4310.5 4324.9 4333.8 4337.6 4345.9 5042.9 5047.1 5053.8 5062.3 5068.6 3560.0 3573.5 3645.0 3652.3 3660.8 5213.5 5266.9 5288.0 5303.1 5319.4 3701.3 3707.6 3716.3 3725.0 3758.0 3792.6 3801.7 3805.0 3814.8 3824.6 4218.5 4326.1 4327.0 4331.4 4388.0 5056.9 5082.3 5082.6 5088.4 5092.7 1262.8 1286.4 1315.2 1332.4 1337.4 866.7 869.5 877.6 881.9 896.4 4133.0 4140.7 4157.5 4158.5 4158.9 4695.7 4712.1 4714.4 4729.6 4730.2 4105.7 4105.9 4109.5 4120.4 4125.9 2455.6 2468.5 2518.1 2522.2 2522.2 4434.8 4438.8 4444.3 4446.5 4458.5 4765.5 4772.7 4792.2 4800.8 4821.4 4262.6 4420.3 4447.7 4465.2 4484.7 4686.6 4693.3 4726.6 4733.3 4758.4 4561.4 4581.2 4583.3 4592.1 4598.4 4144.3 4343.7 4357.9 4442.2 4455.6 3454.7 3492.5 3494.5 3518.2 3524.2 4667.8 4670.3 4701.7 4702.3 5058.2 4934.7 5123.4 5131.5 5140.1 5151.1 5091.4 5101.5 5132.5 5162.3 5172.8 4839.7 5023.7 5053.9 5062.8 5075.1 5090.0 5134.2 5139.3 5144.7 5146.2 5022.9 5063.9 5107.5 5114.6 5121.3 06:58:53 INFO - PROCESS | 16608 | 06:58:53 INFO - PROCESS | 16608 | [#5] yui.html Cycles:180 Average:16174.02 Median:4202.73 stddev:21697.77 (516.3%) stddev-sans-first:21727.27 06:58:53 INFO - PROCESS | 16608 | Values: 637.0 669.8 692.6 734.8 746.6 13044.3 13951.3 14006.5 14014.0 14031.5 12981.7 13389.9 13447.0 13466.2 13513.3 631.7 768.6 775.4 792.6 795.7 797.2 805.8 805.9 806.3 806.6 853.4 855.0 855.0 855.6 855.9 668.6 811.3 834.1 847.0 847.2 612.0 612.1 612.3 612.5 612.6 13490.0 13504.1 13519.9 13532.5 13540.8 12285.7 12690.9 12722.8 13037.9 13095.1 11677.0 11746.8 11816.5 11957.2 12206.8 4192.3 4213.1 4232.1 4267.4 4358.2 58860.7 59329.4 59552.1 60376.7 60736.4 10442.0 10472.4 10597.2 10654.7 11042.3 18825.6 18843.2 18886.3 18903.4 18922.9 6819.7 6951.6 6968.4 7039.4 7202.2 3858.4 3898.2 3951.4 3982.3 4066.8 2856.9 2947.9 2949.8 2950.5 2951.9 476.4 492.3 499.6 501.6 505.6 495.3 497.2 528.4 602.6 607.6 7725.8 7937.8 8041.8 8145.7 8148.0 497.8 521.6 531.2 613.5 640.0 3769.2 3778.7 3921.2 3924.4 3988.7 84521.6 84757.6 91491.5 98551.0 98616.5 49573.3 50677.0 51019.7 60967.4 72010.6 47245.3 52559.7 71961.3 72364.0 75488.0 7966.3 7976.2 8100.8 8115.3 8236.8 31020.7 31566.7 38686.6 38706.9 41102.2 40659.4 51261.0 57104.1 58047.0 59471.4 11505.2 11954.2 12341.8 12794.7 12988.1 13436.8 13641.8 13828.6 13853.5 14041.9 11067.3 11201.3 11241.5 11540.0 11862.6 11689.6 11907.6 11956.6 12041.8 12090.6 11251.8 11494.4 11743.4 11952.0 12250.8 10133.6 10238.0 10317.9 10385.0 10438.2 9915.7 10096.7 10144.9 10155.7 10217.5 06:58:53 INFO - PROCESS | 16608 | -------- Summary: end -------- 06:58:53 INFO - PROCESS | 16608 | 06:58:54 INFO - TEST-INFO | 16608: exit 0 06:58:54 INFO - TEST-OK | dromaeo_css | took 1120283ms 06:58:54 INFO - TEST-START | kraken 06:58:54 INFO - operating with platform_type : linux_ 06:58:54 INFO - Initialising browser for kraken test... 06:58:54 INFO - TEST-INFO | started process 16797 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz9Tryt/profile http://localhost:45941/getInfo.html) 06:58:58 INFO - PROCESS | 16797 | __metrics Screen width/height:1600/1200 06:58:58 INFO - PROCESS | 16797 | colorDepth:24 06:58:58 INFO - PROCESS | 16797 | Browser inner width/height: 1024/697 06:58:58 INFO - PROCESS | 16797 | __metrics 06:58:59 INFO - PROCESS | 16797 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:59:00 INFO - TEST-INFO | 16797: exit 0 06:59:00 INFO - Browser initialized. 06:59:00 INFO - Running cycle 1/1 for kraken test... 06:59:00 INFO - TEST-INFO | started process 16882 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz9Tryt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:59:12 INFO - PROCESS | 16882 | RSS: Main: 159641600 06:59:12 INFO - PROCESS | 16882 | 06:59:15 INFO - PROCESS | 16882 | Cycle 1(1): loaded http://localhost:45941/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45941/tests/kraken/driver.html?testName=audio-beat-detection) 06:59:16 INFO - PROCESS | 16882 | RSS: Main: 217255936 06:59:16 INFO - PROCESS | 16882 | 06:59:19 INFO - PROCESS | 16882 | Cycle 1(1): loaded http://localhost:45941/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45941/tests/kraken/driver.html?testName=audio-dft) 06:59:19 INFO - PROCESS | 16882 | RSS: Main: 204021760 06:59:19 INFO - PROCESS | 16882 | 06:59:22 INFO - PROCESS | 16882 | Cycle 1(1): loaded http://localhost:45941/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45941/tests/kraken/driver.html?testName=audio-fft) 06:59:23 INFO - PROCESS | 16882 | RSS: Main: 270811136 06:59:23 INFO - PROCESS | 16882 | 06:59:25 INFO - PROCESS | 16882 | Cycle 1(1): loaded http://localhost:45941/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45941/tests/kraken/driver.html?testName=audio-oscillator) 06:59:26 INFO - PROCESS | 16882 | RSS: Main: 181690368 06:59:26 INFO - PROCESS | 16882 | 06:59:28 INFO - PROCESS | 16882 | Cycle 1(1): loaded http://localhost:45941/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45941/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:59:29 INFO - PROCESS | 16882 | RSS: Main: 186150912 06:59:29 INFO - PROCESS | 16882 | 06:59:32 INFO - PROCESS | 16882 | Cycle 1(1): loaded http://localhost:45941/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45941/tests/kraken/driver.html?testName=imaging-darkroom) 06:59:32 INFO - PROCESS | 16882 | RSS: Main: 221773824 06:59:32 INFO - PROCESS | 16882 | 06:59:36 INFO - PROCESS | 16882 | Cycle 1(1): loaded http://localhost:45941/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45941/tests/kraken/driver.html?testName=imaging-desaturate) 06:59:36 INFO - PROCESS | 16882 | RSS: Main: 222900224 06:59:36 INFO - PROCESS | 16882 | 06:59:39 INFO - PROCESS | 16882 | Cycle 1(1): loaded http://localhost:45941/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45941/tests/kraken/driver.html?testName=json-parse-financial) 06:59:40 INFO - PROCESS | 16882 | RSS: Main: 222232576 06:59:40 INFO - PROCESS | 16882 | 06:59:42 INFO - PROCESS | 16882 | Cycle 1(1): loaded http://localhost:45941/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45941/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:59:42 INFO - PROCESS | 16882 | RSS: Main: 208334848 06:59:42 INFO - PROCESS | 16882 | 06:59:44 INFO - PROCESS | 16882 | Cycle 1(1): loaded http://localhost:45941/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45941/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:59:45 INFO - PROCESS | 16882 | RSS: Main: 210042880 06:59:45 INFO - PROCESS | 16882 | 06:59:47 INFO - PROCESS | 16882 | Cycle 1(1): loaded http://localhost:45941/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45941/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:59:48 INFO - PROCESS | 16882 | RSS: Main: 214908928 06:59:48 INFO - PROCESS | 16882 | 06:59:50 INFO - PROCESS | 16882 | Cycle 1(1): loaded http://localhost:45941/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45941/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:59:51 INFO - PROCESS | 16882 | RSS: Main: 224526336 06:59:51 INFO - PROCESS | 16882 | 06:59:54 INFO - PROCESS | 16882 | Cycle 1(1): loaded http://localhost:45941/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45941/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:59:55 INFO - PROCESS | 16882 | RSS: Main: 226021376 06:59:55 INFO - PROCESS | 16882 | 06:59:56 INFO - PROCESS | 16882 | Cycle 1(1): loaded http://localhost:45941/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45941/tests/kraken/driver.html?testName=ai-astar) 06:59:57 INFO - PROCESS | 16882 | RSS: Main: 268435456 06:59:57 INFO - PROCESS | 16882 | 06:59:57 INFO - PROCESS | 16882 | __start_tp_report 06:59:57 INFO - PROCESS | 16882 | _x_x_mozilla_page_load 06:59:57 INFO - PROCESS | 16882 | _x_x_mozilla_page_load_details 06:59:57 INFO - PROCESS | 16882 | |i|pagename|runs| 06:59:57 INFO - PROCESS | 16882 | |0;ai-astar;105;114;114;115;116;114;113;115;115;115 06:59:57 INFO - PROCESS | 16882 | |1;audio-beat-detection;147;129;131;188;122;125;153;122;188;122 06:59:57 INFO - PROCESS | 16882 | |2;audio-dft;162;161;164;162;162;160;162;163;161;162 06:59:57 INFO - PROCESS | 16882 | |3;audio-fft;75;75;76;131;76;77;76;75;101;77 06:59:57 INFO - PROCESS | 16882 | |4;audio-oscillator;84;86;119;84;85;86;122;85;84;128 06:59:57 INFO - PROCESS | 16882 | |5;imaging-gaussian-blur;117;117;117;116;118;116;117;118;119;118 06:59:57 INFO - PROCESS | 16882 | |6;imaging-darkroom;146;148;147;147;146;146;147;147;146;146 06:59:57 INFO - PROCESS | 16882 | |7;imaging-desaturate;102;95;95;95;95;95;95;95;94;94 06:59:57 INFO - PROCESS | 16882 | |8;json-parse-financial;64;68;62;64;63;64;64;63;64;63 06:59:57 INFO - PROCESS | 16882 | |9;json-stringify-tinderbox;65;65;66;65;65;65;66;65;65;65 06:59:57 INFO - PROCESS | 16882 | |10;stanford-crypto-aes;79;80;78;78;79;92;83;84;79;84 06:59:57 INFO - PROCESS | 16882 | |11;stanford-crypto-ccm;154;129;130;130;126;139;139;132;166;131 06:59:57 INFO - PROCESS | 16882 | |12;stanford-crypto-pbkdf2;172;169;165;171;169;170;173;171;165;163 06:59:57 INFO - PROCESS | 16882 | |13;stanford-crypto-sha256-iterative;71;71;67;66;67;68;67;69;72;67 06:59:57 INFO - PROCESS | 16882 | __end_tp_report 06:59:57 INFO - PROCESS | 16882 | __start_cc_report 06:59:57 INFO - PROCESS | 16882 | _x_x_mozilla_cycle_collect,1915 06:59:57 INFO - PROCESS | 16882 | __end_cc_report 06:59:57 INFO - PROCESS | 16882 | __startTimestamp1467295197114__endTimestamp 06:59:57 INFO - PROCESS | 16882 | 06:59:57 INFO - PROCESS | 16882 | ------- Summary: start ------- 06:59:57 INFO - PROCESS | 16882 | Number of tests: 14 06:59:57 INFO - PROCESS | 16882 | 06:59:57 INFO - PROCESS | 16882 | [#0] ai-astar Cycles:10 Average:113.60 Median:115.00 stddev:3.13 (2.7%) stddev-sans-first:0.88 06:59:57 INFO - PROCESS | 16882 | Values: 105.0 114.0 114.0 115.0 116.0 114.0 113.0 115.0 115.0 115.0 06:59:57 INFO - PROCESS | 16882 | 06:59:57 INFO - PROCESS | 16882 | [#1] audio-beat-detection Cycles:10 Average:142.70 Median:139.00 stddev:26.15 (18.8%) stddev-sans-first:27.68 06:59:57 INFO - PROCESS | 16882 | Values: 147.0 129.0 131.0 188.0 122.0 125.0 153.0 122.0 188.0 122.0 06:59:57 INFO - PROCESS | 16882 | 06:59:57 INFO - PROCESS | 16882 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.10 (0.7%) stddev-sans-first:1.17 06:59:57 INFO - PROCESS | 16882 | Values: 162.0 161.0 164.0 162.0 162.0 160.0 162.0 163.0 161.0 162.0 06:59:57 INFO - PROCESS | 16882 | 06:59:57 INFO - PROCESS | 16882 | [#3] audio-fft Cycles:10 Average:83.90 Median:76.00 stddev:18.35 (24.1%) stddev-sans-first:19.18 06:59:57 INFO - PROCESS | 16882 | Values: 75.0 75.0 76.0 131.0 76.0 77.0 76.0 75.0 101.0 77.0 06:59:57 INFO - PROCESS | 16882 | 06:59:57 INFO - PROCESS | 16882 | [#4] audio-oscillator Cycles:10 Average:96.30 Median:84.50 stddev:18.57 (22.0%) stddev-sans-first:19.15 06:59:57 INFO - PROCESS | 16882 | Values: 84.0 86.0 119.0 84.0 85.0 86.0 122.0 85.0 84.0 128.0 06:59:57 INFO - PROCESS | 16882 | 06:59:57 INFO - PROCESS | 16882 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.50 stddev:0.95 (0.8%) stddev-sans-first:1.00 06:59:57 INFO - PROCESS | 16882 | Values: 117.0 117.0 117.0 116.0 118.0 116.0 117.0 118.0 119.0 118.0 06:59:57 INFO - PROCESS | 16882 | 06:59:57 INFO - PROCESS | 16882 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 06:59:57 INFO - PROCESS | 16882 | Values: 146.0 148.0 147.0 147.0 146.0 146.0 147.0 147.0 146.0 146.0 06:59:57 INFO - PROCESS | 16882 | 06:59:57 INFO - PROCESS | 16882 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.00 stddev:2.32 (2.4%) stddev-sans-first:0.44 06:59:57 INFO - PROCESS | 16882 | Values: 102.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 94.0 06:59:57 INFO - PROCESS | 16882 | 06:59:57 INFO - PROCESS | 16882 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:64.00 stddev:1.60 (2.5%) stddev-sans-first:1.69 06:59:57 INFO - PROCESS | 16882 | Values: 64.0 68.0 62.0 64.0 63.0 64.0 64.0 63.0 64.0 63.0 06:59:57 INFO - PROCESS | 16882 | 06:59:57 INFO - PROCESS | 16882 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 06:59:57 INFO - PROCESS | 16882 | Values: 65.0 65.0 66.0 65.0 65.0 65.0 66.0 65.0 65.0 65.0 06:59:57 INFO - PROCESS | 16882 | 06:59:57 INFO - PROCESS | 16882 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:81.50 stddev:4.35 (5.3%) stddev-sans-first:4.51 06:59:57 INFO - PROCESS | 16882 | Values: 79.0 80.0 78.0 78.0 79.0 92.0 83.0 84.0 79.0 84.0 06:59:57 INFO - PROCESS | 16882 | 06:59:57 INFO - PROCESS | 16882 | [#11] stanford-crypto-ccm Cycles:10 Average:137.60 Median:135.50 stddev:12.82 (9.5%) stddev-sans-first:12.14 06:59:57 INFO - PROCESS | 16882 | Values: 154.0 129.0 130.0 130.0 126.0 139.0 139.0 132.0 166.0 131.0 06:59:57 INFO - PROCESS | 16882 | 06:59:57 INFO - PROCESS | 16882 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.80 Median:170.50 stddev:3.36 (2.0%) stddev-sans-first:3.36 06:59:57 INFO - PROCESS | 16882 | Values: 172.0 169.0 165.0 171.0 169.0 170.0 173.0 171.0 165.0 163.0 06:59:57 INFO - PROCESS | 16882 | 06:59:57 INFO - PROCESS | 16882 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.50 stddev:2.12 (3.1%) stddev-sans-first:2.05 06:59:57 INFO - PROCESS | 16882 | Values: 71.0 71.0 67.0 66.0 67.0 68.0 67.0 69.0 72.0 67.0 06:59:57 INFO - PROCESS | 16882 | -------- Summary: end -------- 06:59:57 INFO - PROCESS | 16882 | 06:59:58 INFO - TEST-INFO | 16882: exit 0 06:59:58 INFO - TEST-OK | kraken | took 64117ms 06:59:58 INFO - SUITE-END | took 1184s 06:59:58 INFO - Completed test suite (00:19:44) 06:59:58 INFO - javascript benchmark 06:59:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2631.5263252614545, 2637.9736202637973, 2674.5052165349407, 2686.0196028449623, 2690.4753573053263, 4670.813167473297, 4716.834910778123, 4729.59798417135, 4824.782884770189, 4854.19905715557, 4722.315264286676, 4779.522047795219, 4807.783649735761, 4810.254410566367, 4823.13183626947, 4354.172707185632, 4382.101669157831, 4435.624607345502, 4491.550844915499, 4550.135474259897, 4446.0441005183875, 4473.88815279619, 4500.639948804088, 4509.3461448090175, 4534.183846907556, 4295.441592592974, 4296.140771845628, 4349.217140914634, 4351.412559304516, 4409.470863496369, 4351.129774045172, 4352.0, 4356.586124318216, 4410.140022695576, 4425.712328698656, 4391.758453285068, 4395.077033822901, 4397.6306723834605, 4439.489458712224, 4458.910821783546, 4671.462781780071, 4739.0, 4799.688020278671, 4811.0, 4813.422389313269, 5096.745162741885, 5127.051495473349, 5138.74306284688, 5149.665271757323, 5151.381834179885, 5137.717425541594, 5161.071007218737, 5169.586433085344, 5173.430922598511, 5174.2238664200295, 4662.184117779375, 4763.404574428197, 4797.95202047982, 4799.520047995173, 4873.171560834667, 5299.5760339172775, 5330.853866418739, 5336.2529245904825, 5337.946620533745, 5340.065488539568, 4914.262860570871, 5073.518015788494, 5118.564921981599, 5127.974405118991, 5129.820456284012, 5005.649604527648, 5115.130427827278, 5115.590752739772, 5123.38519377677, 5184.818531351385, 5093.312402825645, 5101.336826212643, 5104.285400043997, 5108.638260990877, 5148.716820574829, 4950.950490495049, 5040.218766091261, 5085.338905942203, 5096.439391666913, 5097.158968770112, 4332.176886391576, 4333.155034768253, 4348.804303806336, 4390.253656878338, 4391.055922976575, 3794.4118661607495, 3810.3903375459795, 3814.4278358246484, 3831.348670725983, 3844.2119365529998, 4344.47866256045, 4380.299152135707, 4493.618042466427, 4524.9547504524535, 4538.0, 5122.538971492583, 5124.410692770379, 5129.8717532062, 5131.307273518102, 5166.715830629351, 4469.4860091089295, 4508.842190523316, 4513.571210734975, 4559.430071241095, 4562.06477672083, 4634.0500197460115, 4677.391939047902, 4682.204025315705, 4682.438107427062, 4725.4565724941385, 4675.205215113371, 4770.475247722678, 4912.312276281395, 4912.606991440748, 4955.207166853286, 5056.924146137884, 5147.845564633067, 5177.145770947752, 5188.299579556711, 5192.558632516128, 4833.685810422311, 4838.612910967044, 4839.806407743651, 4840.34655321527, 4891.217405215149, 4900.4854490278, 5065.062963351792, 5070.416902056163, 5074.847754567221, 5124.1032819257225, 5120.18077107661, 5164.380274366949, 5186.0, 5207.635465517377, 5217.686938783685, 5040.773165207501, 5050.671706339076, 5073.923891141562, 5074.746262686925, 5125.641205115606, 4834.5890599298045, 4999.950000499948, 5048.873778155576, 5067.113255180402, 5068.467810879952, 4978.775955081957, 4994.925076123934, 5074.543291103819, 5078.0, 5079.593632509316, 5094.1849304111165, 5115.488451154854, 5117.513836185556, 5120.718360490208, 5168.198929165986, 4818.277258411266, 4897.191963326154, 4952.2819191217795, 5005.724685142352, 5007.499250074963], "value": 4725.755487798523, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.4489283823293, 582.490320969152, 596.1088173181095, 602.3165253117538, 607.4168797953964, 27153.59269610955, 30381.544276835837, 39870.99999999996, 40922.18155636886, 40995.0, 41351.0, 41779.16441671165, 41794.37308440376, 41836.58163418365, 41857.37213941786, 7572.9621351893165, 7855.646495907669, 7998.880016799752, 8001.5199088054615, 8003.51978881266, 7515.3987680985665, 7777.533347999138, 7782.727604533842, 10000.849987250198, 10284.280100392976, 10310.0, 10326.793464130713, 10374.740631484197, 10388.688339349794, 10401.635942742005, 10213.080822725953, 10250.38497690141, 10263.486825658687, 10285.0, 10291.58833646657, 7457.254274572553, 7677.923220767832, 7690.115636701795, 9807.460589667566, 10226.693199204035, 38933.41599876004, 39241.411378829056, 39328.80335598332, 39347.21305573873, 39363.606363936284, 3215.244417561871, 3268.2809781847955, 3478.9826050869583, 3497.283056973314, 3618.493410922473, 28653.856730716212, 29584.11247662552, 30003.249918751986, 30473.847630761928, 30836.53745193824, 3325.7505687073326, 3364.3103163851597, 3386.4243078676686, 3509.3332266869215, 3514.4201206801104, 257320.0, 257383.71308143527, 257541.0, 259734.0, 260831.0, 51576.48423515792, 52097.21854172191, 52194.0, 52289.215661765105, 52468.21297680538, 54615.0, 54708.0, 54731.45268547343, 54804.72597637066, 54934.0, 13543.0, 13985.440582376794, 14007.599240075911, 14013.929930350487, 14026.298685065705, 9793.314467987173, 11735.823962640567, 11757.647270581896, 11853.525858965717, 11874.703132421759, 15005.0, 15442.0734755915, 15447.922760386125, 15959.281832317341, 16022.599435014217, 5786.855328616818, 5788.565857560699, 5810.883782324415, 5945.494632956161, 5988.191594134736, 825.3933358981144, 858.1932982995963, 887.6538150121457, 901.4090130918934, 930.7207837648679, 28396.290092747848, 28613.42773144567, 28682.569761453597, 28937.42125157485, 28943.0, 948.4593781544592, 964.4599024546277, 968.8740463739668, 983.0955520920627, 1000.7648202672366, 14528.200948947699, 15139.621509462351, 15525.0, 15670.294836732146, 16300.755488667679, 403798.0, 404605.884852881, 404642.0, 405279.0, 408311.0, 50813.729656758136, 51120.488795111574, 51319.74340128276, 51375.743121284155, 51528.74235628798, 1110.9500072496758, 1204.795184818583, 1215.7872372334807, 1236.5610208376077, 1244.8506179258547, 27575.448491030467, 28800.279993000342, 28827.0, 29213.85393073021, 29476.410471790874, 41507.37738933979, 51705.224421634455, 52807.207891880884, 52901.470985289656, 52946.0, 370674.0, 371064.0, 372749.0, 375488.0, 376114.0, 33141.0, 38687.6131238684, 39405.2118957625, 39786.801065994485, 40665.186696265315, 42475.787621061696, 42783.14433711246, 42807.78596107124, 43173.78413107914, 43801.34297985469, 36665.45001824921, 37489.25021499609, 37774.0, 38276.80861595674, 38390.80804596071, 37878.24243515059, 37920.81039594785, 38245.4263186058, 38521.807390962866, 38777.0, 36305.81847090748, 36809.263814724094, 37058.25883482369, 37440.625593743716, 37601.2479750409, 31718.682813171574, 33179.83410082934, 33285.66714332923, 33641.49537756887, 33818.66181338155, 25273.0, 25620.743792561836, 25735.525704029715, 25736.8713156433, 26016.0], "value": 18350.340900926298, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.2932582195233, 361.91133172372764, 364.9726270529711, 369.918617904061, 379.31154953758926, 13179.472821087156, 16614.584635384123, 16842.747358789613, 17699.55751106223, 18596.628067438643, 16811.915940420313, 17328.653426931454, 17502.0, 17575.91212043941, 17599.560010999732, 5169.199032014903, 5201.739913004353, 5354.116570765819, 5356.9732151339185, 5359.5712343012465, 3755.6244375562496, 5233.842984710464, 5899.970500147493, 6214.596051256676, 6233.345498722637, 6080.756769729205, 6275.2469703635625, 6291.402316779899, 6293.559450838443, 6301.6534090625, 6185.319614842364, 6248.937510624881, 6258.49932005443, 6260.12358269838, 6266.937330626703, 3405.4891766235264, 5069.315642388304, 5372.409035006146, 5379.731013449312, 5497.202905578709, 21653.783462165335, 21870.89064554683, 21894.0, 21919.232826850985, 22202.22292219781, 2087.5720477302116, 2163.664631982045, 2176.7170267865076, 2364.2316247219724, 2407.1214006887535, 13004.674883127904, 13457.461701531927, 13878.375473103735, 13927.651808704763, 14186.716265674731, 1757.912104394775, 1761.1634473625054, 1761.903812807687, 1786.7051936430603, 1807.4396936949456, 53938.0, 68958.65520672414, 68998.31001689969, 71069.28930710678, 71682.64158679225, 8743.0, 9083.0, 9538.236941044699, 9650.71047868565, 9859.802803943881, 12929.54746583884, 13295.66760830987, 13372.866271337161, 13374.799378009338, 13389.0, 7124.287571242834, 7231.023811785447, 7618.771436856903, 7677.270659287359, 7835.2948234658015, 6684.231313399021, 6706.396424321834, 6765.763198288037, 6786.660666966632, 6871.6564171791215, 6196.752129914843, 6264.436200741955, 6309.211348581427, 6378.0, 6483.4164925156965, 1734.2802736864312, 1757.147783325112, 1761.603639181174, 1779.7330400440037, 1806.9819301807076, 901.3870568013682, 906.8685040669066, 936.8828896387952, 937.5874615169304, 949.0604301741364, 17566.91216543909, 18079.819201808077, 18137.36519221821, 18386.81613183878, 18497.075146242634, 905.7961958559404, 911.6171208092617, 917.3303488453466, 923.7598224461689, 959.9424034557949, 10074.294799363974, 10544.736381590521, 10577.524011419504, 10618.415987120783, 10664.733381665521, 387371.0, 389517.0, 390209.0, 425849.0, 435219.0, 85509.57245213859, 89597.55201223952, 89705.55147224353, 91178.54410727904, 91191.0, 912.9178373946244, 933.1875330895638, 937.6765016069445, 941.261110028638, 942.8679984802134, 16304.923769057736, 16465.83534164691, 16656.750148748022, 16726.330946761995, 17068.573285667462, 27229.727702722717, 34877.30245395027, 35941.82029089838, 38426.23147536978, 39645.405318919664, 46977.0, 49871.50128498814, 51992.0, 52793.0, 52915.0, 7525.510841795266, 7528.585927774025, 7550.7734767957045, 7610.200928902385, 7680.385569154342, 10055.371646138177, 11232.494537745984, 11620.941895290469, 11856.76286474283, 12375.381230938598, 9630.374025688308, 9881.0, 10232.0, 10370.325928814604, 10439.0, 9928.851067233853, 9947.05502977216, 10253.179745620482, 10671.0, 10812.243142979916, 9631.807363852824, 10220.948895255477, 10258.43578603184, 10501.369917804956, 10635.308704934154, 7611.505252158592, 7618.733344332922, 7696.076470823537, 7757.301842834172, 7835.294823465915, 7471.290227428385, 8927.598258078273, 9670.468124252951, 9728.513574321114, 10273.486325683836], "value": 8552.67628319562, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1383.7163381506791, 1425.1449130521685, 1455.461479252676, 1683.8063622683394, 1708.803487598925, 7429.108506979163, 7878.92121078789, 7933.087694915086, 7947.7218297359605, 7963.800904977378, 6723.36128067834, 7432.405407567395, 7627.580483073429, 7644.426667999895, 7825.0, 2202.0421116814196, 2219.0125394199586, 2222.1777942161425, 2224.3327001899447, 2225.6995305633695, 1917.2906024770855, 1992.342526966105, 2193.473566344074, 2223.855449395792, 2229.3646310801423, 1960.0787629813965, 2133.807957283844, 2194.648856183011, 2196.0447205465593, 2216.789405006522, 2148.430665873545, 2163.167180635451, 2167.674848772681, 2168.490404754881, 2176.0, 2132.1045161032403, 2137.8824164670937, 2137.925172618951, 2144.967825482619, 2160.751513575943, 7888.211178882066, 7942.722004729864, 7953.761387158394, 7959.522428654299, 7961.203879611992, 4456.309272062836, 4474.39595654589, 4477.753723545204, 4505.008898042425, 4505.797239124247, 2898.0726167626367, 2911.6214892063895, 3025.6671766105933, 3026.546018097281, 3040.407120611482, 935.6865450074233, 950.6815216902346, 963.8746962894779, 970.0251247496221, 976.8485884687884, 10831.67504974852, 10832.78334433307, 10841.0, 10845.457727113613, 10859.891401085966, 4016.879493615196, 4172.290710579209, 4275.46556680415, 4277.486701595828, 4302.139572085595, 9088.727338179866, 9192.218661413855, 9197.218236449842, 9201.585928633227, 9205.631774728936, 4679.27471241958, 4688.0858232644305, 4696.0, 4698.624110071186, 4703.341532185496, 4181.163767246502, 4267.402563641031, 4273.829046838154, 4273.893152671208, 4278.657707383401, 3580.8925732228076, 3583.4087375582735, 3617.366960781905, 3661.41417373219, 3682.226732386229, 1036.6734478639205, 1104.1332553945274, 1171.273810237641, 1172.6775136837268, 1177.140687298277, 677.0791723256367, 770.1182146442292, 811.6591031766673, 843.6077224090827, 857.8241460500583, 4977.776000080005, 5178.585713142939, 5190.24741412493, 5267.71027593486, 5361.222622719762, 886.7916039730658, 897.5108565831507, 897.6364572348209, 904.0913881549133, 906.8775715278485, 3654.9634503654624, 3661.853525858989, 3676.980713195519, 3684.244729830378, 3709.8330575124182, 8812.8678069829, 9201.17189452939, 9272.768180795534, 9311.860322095174, 9327.486988215578, 9106.089391060841, 9196.402233854778, 9198.172164505228, 9213.30900182489, 9227.169554740105, 6398.776042838572, 6606.7026983785845, 6630.905900526455, 6758.662066896635, 6793.354631310018, 5070.619703522177, 5153.5361817436615, 5214.661047031931, 5320.308359913187, 5398.433164517826, 8436.578171091543, 8467.53428561435, 8499.74500764978, 8538.743837684879, 8550.0, 8519.190676885686, 8566.571671416528, 8596.527191004305, 8811.64753409882, 8814.691485797966, 6509.837254068686, 6549.967250163719, 6551.80344589663, 6565.0, 6579.934200657932, 7158.713651454092, 7192.029076074872, 7216.639168041682, 7217.350438460564, 7224.0, 6444.581102228341, 6607.0, 6700.262971073081, 6700.262971073081, 6931.584104953719, 6551.868962620816, 6721.495887808336, 6783.796486105425, 6836.28219036994, 7013.509054366145, 6116.052011937979, 6129.908051379144, 6170.580766423658, 6176.66028368444, 6186.381361863778, 4531.909361812811, 4540.182767101954, 4557.339185817971, 4629.768511574341, 4688.742119183477, 4597.057603191404, 4715.905681886412, 4727.267273572602, 4728.432588089451, 4771.71369717818], "value": 4106.314800816819, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.8117814009964, 294.1000538352641, 299.11462072266085, 303.03936521227706, 304.0953164336099, 4737.242041273397, 4891.902161956758, 4938.555530002299, 4968.155413579691, 5024.7236401997925, 4714.717116972975, 4847.1517484440255, 4851.951480485194, 4857.344258525098, 4866.197077482211, 3835.2904712628115, 3838.923221535568, 3841.0781412460947, 3841.1165431950667, 3851.845926162964, 3631.6368363163606, 3651.908702282451, 3840.790151102394, 3842.193139440707, 3847.6921846252235, 3801.9049523761987, 3802.372608519605, 3803.8858834235016, 3811.866584669537, 3823.4647149399107, 3790.4882840816413, 3792.9000589828916, 3798.753081049723, 3799.411091280856, 3805.8858234253016, 3358.7999860091677, 3370.612379576331, 3371.6291207967106, 3374.5444365010653, 3388.8305584720665, 4635.930461043087, 4729.196036673739, 4751.40607424072, 4780.4741478437345, 4826.469088400273, 4310.547392523803, 4324.870253892388, 4333.826646934119, 4337.592636086971, 4345.9348109778375, 5042.873928151789, 5047.116754567936, 5053.797848086109, 5062.341895553592, 5068.645194836363, 3559.982200088983, 3573.4639804029343, 3645.0, 3652.3425783358985, 3660.8468332475186, 5213.53078222958, 5266.920996185098, 5287.995280896617, 5303.071962406602, 5319.3616765987945, 3701.333759923186, 3707.647773461517, 3716.2939041582013, 3725.0, 3757.981210093932, 3792.58281589025, 3801.676857467091, 3805.0, 3814.7520411173186, 3824.6366595173413, 4218.451601291874, 4326.134773045404, 4326.956730432718, 4331.436913201263, 4388.0, 5056.924146137811, 5082.313887625197, 5082.567981721521, 5088.440271570124, 5092.668976516515, 1262.8042653388738, 1286.3889652415028, 1315.1648703073427, 1332.380443093966, 1337.4249072898747, 866.6663334616092, 869.5304535550858, 877.5919197573031, 881.9382643215042, 896.4262871762078, 4133.028738246509, 4140.716377922854, 4157.48031496063, 4158.480189976253, 4158.91682166355, 4695.718256904528, 4712.09160290083, 4714.4106986626675, 4729.597984171315, 4730.243161094278, 4105.7331273467125, 4105.938410923838, 4109.547949725527, 4120.443740095108, 4125.876223713293, 2455.5699936263863, 2468.4816188600234, 2518.0934863449143, 2522.1928982725717, 2522.243327001892, 4434.822607095744, 4438.800253988514, 4444.266695995125, 4446.466424029137, 4458.487273963471, 4765.451973023078, 4772.665913386029, 4792.155020317134, 4800.759962001886, 4821.373221481185, 4262.57203836712, 4420.336949457607, 4447.666425018137, 4465.218586747371, 4484.730916144977, 4686.5782079613, 4693.3104082530945, 4726.574608285133, 4733.290006499053, 4758.357621721162, 4561.384213131185, 4581.198290299251, 4583.2958554453035, 4592.058627981322, 4598.436531579279, 4144.321549772347, 4343.740315308525, 4357.934630980474, 4442.200403927324, 4455.576720211575, 3454.740894432877, 3492.4586689063235, 3494.4583589543663, 3518.2435776308216, 3524.22467057247, 4667.766611669335, 4670.299455081765, 4701.694389864648, 4702.27114797207, 5058.192703049843, 4934.728589927445, 5123.410807757006, 5131.512506311894, 5140.12617854973, 5151.072806894795, 5091.389033316026, 5101.540861322499, 5132.538071573576, 5162.315595890192, 5172.844814655567, 4839.733814640229, 5023.69857808518, 5053.862880851779, 5062.82280120194, 5075.11185542536, 5090.0, 5134.229865520202, 5139.301866520107, 5144.717040562805, 5146.150885103916, 5022.924656130088, 5063.924041139459, 5107.463716309734, 5114.5652619527755, 5121.257417674342], "value": 3723.6597612505097, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [636.964966926819, 669.819148829816, 692.5533031194876, 734.7979305690934, 746.5896673967751, 13044.28256445895, 13951.302434878253, 14006.509772157977, 14014.0, 14031.508897188587, 12981.675458113528, 13389.866101338983, 13447.0, 13466.192028478297, 13513.324333783321, 631.7094136697125, 768.5657603454031, 775.4145620056863, 792.6353877216487, 795.7493389582263, 797.1868693932186, 805.8186907945724, 805.87508936115, 806.3347738116048, 806.6410447350931, 853.4068822168596, 854.995725021374, 855.0338117926765, 855.6106971328031, 855.9443636163661, 668.5787953589256, 811.3347055414563, 834.1033389106734, 846.9618867150962, 847.1824689174945, 612.0085461552313, 612.1124369664005, 612.2775125352083, 612.4518555892496, 612.604869858943, 13490.0, 13504.122232054886, 13519.864801352058, 13532.458701651922, 13540.796888046687, 12285.69285767854, 12690.87309126906, 12722.809157862639, 13037.890185216615, 13095.083344165912, 11677.0, 11746.823797643043, 11816.468258928282, 11957.162998590102, 12206.816897746541, 4192.329227323644, 4213.136307057046, 4232.132412855357, 4267.445232119836, 4358.193734159191, 58860.70569647167, 59329.40670593282, 59552.106718399256, 60376.69811650958, 60736.39263607396, 10442.0, 10472.371657700562, 10597.20520960931, 10654.680359589225, 11042.33745975244, 18825.623487530174, 18843.24627014904, 18886.3389781357, 18903.43289701311, 18922.90538547326, 6819.69825225309, 6951.617661028692, 6968.407685346701, 7039.436845052383, 7202.207757146814, 3858.440526123696, 3898.2398432305995, 3951.3677811550588, 3982.342913419311, 4066.755994640331, 2856.9142925712263, 2947.926301842428, 2949.7787665925143, 2950.4836653585535, 2951.8671659775364, 476.4092525268642, 492.29355874320464, 499.557891266232, 501.57115666104954, 505.57784250151536, 495.2768957322278, 497.2292945933788, 528.3501293409051, 602.599271484458, 607.5777334752305, 7725.845483090419, 7937.801554961172, 8041.839163216703, 8145.674173033012, 8147.959260203661, 497.8008796481436, 521.5644936478008, 531.232369226464, 613.4816080412045, 640.0271587187449, 3769.227308401771, 3778.7165962552917, 3921.1961547882615, 3924.372100463969, 3988.700847436454, 84521.57739211388, 84757.57621211978, 91491.54254228686, 98551.0, 98616.50691746495, 49573.25640115401, 50677.0, 51019.744901276, 60967.39032609706, 72010.63994680098, 47245.346412875384, 52559.73720131375, 71961.28038719755, 72364.0, 75488.0, 7966.322862556516, 7976.20237976221, 8100.756977290455, 8115.269625733712, 8236.794080148044, 31020.68979310178, 31566.684333156376, 38686.613133868304, 38706.908597321104, 41102.1779564413, 40659.390109148975, 51261.0, 57104.1434378493, 58047.0, 59471.40528594832, 11505.23123502991, 11954.222975506564, 12341.814872776737, 12794.744105118032, 12988.090833641932, 13436.798448023092, 13641.795373069213, 13828.585142445743, 13853.479341565575, 14041.929790350983, 11067.335959842436, 11201.271917325348, 11241.49413276388, 11540.0, 11862.584809531625, 11689.649310520697, 11907.583234586747, 11956.641300760992, 12041.808920635864, 12090.637280881587, 11251.831222531833, 11494.367809770543, 11743.412829358327, 11952.0, 12250.75498490043, 10133.64532241368, 10238.0, 10317.9484102579, 10385.0, 10438.164946804389, 9915.678247787073, 10096.708719704033, 10144.898551014396, 10155.695329140137, 10217.540210690388], "value": 6507.998275767859, "unit": "score"}], "name": "dromaeo_css", "value": 6476.743551675882, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 114.0, 115.0, 116.0, 114.0, 113.0, 115.0, 115.0, 115.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 129.0, 131.0, 188.0, 122.0, 125.0, 153.0, 122.0, 188.0, 122.0], "value": 142.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 164.0, 162.0, 162.0, 160.0, 162.0, 163.0, 161.0, 162.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 131.0, 76.0, 77.0, 76.0, 75.0, 101.0, 77.0], "value": 83.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 119.0, 84.0, 85.0, 86.0, 122.0, 85.0, 84.0, 128.0], "value": 96.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 118.0, 116.0, 117.0, 118.0, 119.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 68.0, 62.0, 64.0, 63.0, 64.0, 64.0, 63.0, 64.0, 63.0], "value": 63.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 65.0, 65.0, 65.0, 66.0, 65.0, 65.0, 65.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 78.0, 78.0, 79.0, 92.0, 83.0, 84.0, 79.0, 84.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 129.0, 130.0, 130.0, 126.0, 139.0, 139.0, 132.0, 166.0, 131.0], "value": 137.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 169.0, 165.0, 171.0, 169.0, 170.0, 173.0, 171.0, 165.0, 163.0], "value": 168.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 67.0, 66.0, 67.0, 68.0, 67.0, 69.0, 72.0, 67.0], "value": 68.5, "unit": "score"}], "name": "kraken", "value": 1543.3999999999996, "alertThreshold": 2.0}]} 06:59:58 INFO - Return code: 0 06:59:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:59:58 INFO - # TBPL SUCCESS # 06:59:58 INFO - Running post-action listener: _resource_record_post_action 06:59:58 INFO - ##### 06:59:58 INFO - ##### Finished run-tests step (success) 06:59:58 INFO - ##### 06:59:58 INFO - Running post-run listener: _resource_record_post_run 06:59:58 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 12288; Write bytes: 535236608; Read time: 36; Write time: 678188 06:59:58 INFO - TinderboxPrint: CPU usage
13.1% 06:59:58 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 36 06:59:58 INFO - TinderboxPrint: I/O write bytes / time
535,236,608 / 678,188 06:59:58 INFO - TinderboxPrint: CPU idle
8,331.2 (86.9%) 06:59:58 INFO - TinderboxPrint: CPU user
1,208.8 (12.6%) 06:59:58 INFO - TinderboxPrint: Swap in / out
0 / 0 06:59:58 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 252424192; Read time: 0; Write time: 379656 06:59:59 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 8192; Write bytes: 282812416; Read time: 24; Write time: 298532 06:59:59 INFO - Running post-run listener: _upload_blobber_files 06:59:59 INFO - Blob upload gear active. 06:59:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:59:59 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:59:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:59:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:59:59 INFO - (blobuploader) - INFO - Open directory for files ... 06:59:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:59:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:59:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:00:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:00:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:00:03 INFO - (blobuploader) - INFO - Done attempting. 07:00:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:00:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:00:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:00:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:00:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:00:04 INFO - (blobuploader) - INFO - Done attempting. 07:00:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:00:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:00:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:00:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:00:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:00:05 INFO - (blobuploader) - INFO - Done attempting. 07:00:05 INFO - (blobuploader) - INFO - Iteration through files over. 07:00:05 INFO - Return code: 0 07:00:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:00:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:00:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2722fa7a86db9482d405465176597e3ddd59d8f64aeae52ddcc6d556d1ce453f32a5ace3023b7bfd15a5249aa750d7e460619d93ad8c111f9bc3edc1aa01227c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0f1f46e558601e4f8424f90deb445002223c21f1c86c73a0490878355f521bcfc57fc614e5eb0cb47543334c3d52505cdf96b2a68df2e78e482e2599861c6d80", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4288b3a3948ee98dfdbe2aec55978e9ec232b8115eb83ca3dd39fcc58b338bf0e6033f1411b72321d97dd90ce33a7a7f30f740ba9f037e453daceb7ef3281703"} 07:00:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:00:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:00:05 INFO - Contents: 07:00:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2722fa7a86db9482d405465176597e3ddd59d8f64aeae52ddcc6d556d1ce453f32a5ace3023b7bfd15a5249aa750d7e460619d93ad8c111f9bc3edc1aa01227c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0f1f46e558601e4f8424f90deb445002223c21f1c86c73a0490878355f521bcfc57fc614e5eb0cb47543334c3d52505cdf96b2a68df2e78e482e2599861c6d80", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4288b3a3948ee98dfdbe2aec55978e9ec232b8115eb83ca3dd39fcc58b338bf0e6033f1411b72321d97dd90ce33a7a7f30f740ba9f037e453daceb7ef3281703"} 07:00:05 INFO - Running post-run listener: copy_logs_to_upload_dir 07:00:05 INFO - Copying logs to upload dir... 07:00:05 INFO - mkdir: /builds/slave/test/build/upload/logs 07:00:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.533935 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-06-30 07:00:05.177849) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 07:00:05.185019) ========= 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=d2a8c569965ab8367867b893000001a1-1467292969.246300-16484698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2722fa7a86db9482d405465176597e3ddd59d8f64aeae52ddcc6d556d1ce453f32a5ace3023b7bfd15a5249aa750d7e460619d93ad8c111f9bc3edc1aa01227c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0f1f46e558601e4f8424f90deb445002223c21f1c86c73a0490878355f521bcfc57fc614e5eb0cb47543334c3d52505cdf96b2a68df2e78e482e2599861c6d80", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4288b3a3948ee98dfdbe2aec55978e9ec232b8115eb83ca3dd39fcc58b338bf0e6033f1411b72321d97dd90ce33a7a7f30f740ba9f037e453daceb7ef3281703"} build_url:https://queue.taskcluster.net/v1/task/WSKjThyKTY226vXbtF4uYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011270 build_url: 'https://queue.taskcluster.net/v1/task/WSKjThyKTY226vXbtF4uYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2722fa7a86db9482d405465176597e3ddd59d8f64aeae52ddcc6d556d1ce453f32a5ace3023b7bfd15a5249aa750d7e460619d93ad8c111f9bc3edc1aa01227c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0f1f46e558601e4f8424f90deb445002223c21f1c86c73a0490878355f521bcfc57fc614e5eb0cb47543334c3d52505cdf96b2a68df2e78e482e2599861c6d80", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4288b3a3948ee98dfdbe2aec55978e9ec232b8115eb83ca3dd39fcc58b338bf0e6033f1411b72321d97dd90ce33a7a7f30f740ba9f037e453daceb7ef3281703"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 07:00:05.210900) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 07:00:05.211225) ========= 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=d2a8c569965ab8367867b893000001a1-1467292969.246300-16484698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004438 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 07:00:05.297593) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 07:00:05.297925) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 07:00:05.298238) ========= ========= Total master_lag: 0.20 =========