builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-002 starttime: 1468631762.16 results: success (0) buildid: 20160715170151 builduid: fa2845cc6e254765b419f86122260b9d revision: 0c27d48b278dba5493f9c98581acfd71889f7b63 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 18:16:02.163218) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 18:16:02.163638) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 18:16:02.163898) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 18:16:02.221263) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 18:16:02.221529) ========= 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=a0d2d2de893abaa8702a9954000001a7-1468631021.344905-55548007 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-15 18:16:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 34.4M=0s 2016-07-15 18:16:02 (34.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.215012 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 18:16:02.467996) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 18:16:02.468314) ========= 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=a0d2d2de893abaa8702a9954000001a7-1468631021.344905-55548007 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.058513 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 18:16:02.539739) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 18:16:02.540028) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0c27d48b278dba5493f9c98581acfd71889f7b63 --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 0c27d48b278dba5493f9c98581acfd71889f7b63 --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=a0d2d2de893abaa8702a9954000001a7-1468631021.344905-55548007 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-15 18:16:02,543 truncating revision to first 12 chars 2016-07-15 18:16:02,543 Setting DEBUG logging. 2016-07-15 18:16:02,543 attempt 1/10 2016-07-15 18:16:02,543 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0c27d48b278d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-15 18:16:02,859 unpacking tar archive at: fx-team-0c27d48b278d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.681796 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 18:16:03.234085) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 18:16:03.234387) ========= script_repo_revision: 0c27d48b278dba5493f9c98581acfd71889f7b63 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 18:16:03.235085) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 18:16:03.235382) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 18:16:03.246026) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-07-15 18:16:03.246324) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=a0d2d2de893abaa8702a9954000001a7-1468631021.344905-55548007 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:16:03 INFO - MultiFileLogger online at 20160715 18:16:03 in /builds/slave/test 18:16:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 18:16:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:16:03 INFO - {'append_to_log': False, 18:16:03 INFO - 'base_work_dir': '/builds/slave/test', 18:16:03 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 18:16:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:16:03 INFO - 'branch': 'Fx-Team-Non-PGO', 18:16:03 INFO - 'buildbot_json_path': 'buildprops.json', 18:16:03 INFO - 'config_files': ('talos/linux_config.py',), 18:16:03 INFO - 'default_actions': ('clobber', 18:16:03 INFO - 'read-buildbot-config', 18:16:03 INFO - 'download-and-extract', 18:16:03 INFO - 'populate-webroot', 18:16:03 INFO - 'create-virtualenv', 18:16:03 INFO - 'install', 18:16:03 INFO - 'run-tests'), 18:16:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:16:03 INFO - 'download_minidump_stackwalk': True, 18:16:03 INFO - 'download_symbols': 'ondemand', 18:16:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:16:03 INFO - 'tooltool.py': '/tools/tooltool.py', 18:16:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:16:03 INFO - '/tools/misc-python/virtualenv.py')}, 18:16:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:16:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:16:03 INFO - 'installer_path': 'installer.exe', 18:16:03 INFO - 'log_level': 'info', 18:16:03 INFO - 'log_name': 'talos', 18:16:03 INFO - 'log_to_console': True, 18:16:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:16:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:16:03 INFO - 'opt_config_files': (), 18:16:03 INFO - 'pip_index': False, 18:16:03 INFO - 'sps_profile': False, 18:16:03 INFO - 'sps_profile_interval': 0, 18:16:03 INFO - 'suite': 'dromaeojs-e10s', 18:16:03 INFO - 'system_bits': '32', 18:16:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:16:03 INFO - 'title': 'talos-linux64-ix-002', 18:16:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:16:03 INFO - 'use_talos_json': True, 18:16:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:16:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:16:03 INFO - 'work_dir': 'build'} 18:16:03 INFO - ##### 18:16:03 INFO - ##### Running clobber step. 18:16:03 INFO - ##### 18:16:03 INFO - Running pre-action listener: _resource_record_pre_action 18:16:03 INFO - Running main action method: clobber 18:16:03 INFO - rmtree: /builds/slave/test/build 18:16:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:16:05 INFO - Running post-action listener: _resource_record_post_action 18:16:05 INFO - ##### 18:16:05 INFO - ##### Finished clobber step (success) 18:16:05 INFO - ##### 18:16:05 INFO - ##### 18:16:05 INFO - ##### Running read-buildbot-config step. 18:16:05 INFO - ##### 18:16:05 INFO - Running pre-action listener: _resource_record_pre_action 18:16:05 INFO - Running main action method: read_buildbot_config 18:16:05 INFO - Using buildbot properties: 18:16:05 INFO - { 18:16:05 INFO - "project": "", 18:16:05 INFO - "product": "firefox", 18:16:05 INFO - "script_repo_revision": "production", 18:16:05 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 18:16:05 INFO - "repository": "", 18:16:05 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 18:16:05 INFO - "buildid": "20160715170151", 18:16:05 INFO - "pgo_build": "False", 18:16:05 INFO - "basedir": "/builds/slave/test", 18:16:05 INFO - "buildnumber": 1475, 18:16:05 INFO - "slavename": "talos-linux64-ix-002", 18:16:05 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:16:05 INFO - "platform": "ubuntu64_hw", 18:16:05 INFO - "scheduler": "tests-fx-team-linux64-talos", 18:16:05 INFO - "branch": "fx-team", 18:16:05 INFO - "repo_path": "integration/fx-team", 18:16:05 INFO - "revision": "0c27d48b278dba5493f9c98581acfd71889f7b63", 18:16:05 INFO - "stage_platform": "linux64", 18:16:05 INFO - "builduid": "fa2845cc6e254765b419f86122260b9d", 18:16:05 INFO - "slavebuilddir": "test" 18:16:05 INFO - } 18:16:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZMP9nlweSZ2bNNrwCzRWcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 18:16:05 INFO - Running post-action listener: _resource_record_post_action 18:16:05 INFO - ##### 18:16:05 INFO - ##### Finished read-buildbot-config step (success) 18:16:05 INFO - ##### 18:16:05 INFO - ##### 18:16:05 INFO - ##### Running download-and-extract step. 18:16:05 INFO - ##### 18:16:05 INFO - Running pre-action listener: _resource_record_pre_action 18:16:05 INFO - Running main action method: download_and_extract 18:16:05 INFO - mkdir: /builds/slave/test/build/tests 18:16:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:05 INFO - https://queue.taskcluster.net/v1/task/ZMP9nlweSZ2bNNrwCzRWcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:16:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMP9nlweSZ2bNNrwCzRWcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:16:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMP9nlweSZ2bNNrwCzRWcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:16:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMP9nlweSZ2bNNrwCzRWcw/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 18:16:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMP9nlweSZ2bNNrwCzRWcw/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 18:16:11 INFO - Downloaded 1361 bytes. 18:16:11 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:16:11 INFO - Using the following test package requirements: 18:16:11 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 18:16:11 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:16:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:16:11 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:16:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:16:11 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:16:11 INFO - u'jsshell-linux-x86_64.zip'], 18:16:11 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:16:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:16:11 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 18:16:11 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:16:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:16:11 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:16:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:16:11 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:16:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:16:11 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:16:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:16:11 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:16:11 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')]} 18:16:11 INFO - https://queue.taskcluster.net/v1/task/ZMP9nlweSZ2bNNrwCzRWcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:16:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMP9nlweSZ2bNNrwCzRWcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:16:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMP9nlweSZ2bNNrwCzRWcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:16:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMP9nlweSZ2bNNrwCzRWcw/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 18:16:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMP9nlweSZ2bNNrwCzRWcw/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 18:16:15 INFO - Downloaded 22757638 bytes. 18:16:15 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'] 18:16:15 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 18:16:16 INFO - Return code: 0 18:16:16 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 18:16:16 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')]} 18:16:16 INFO - https://queue.taskcluster.net/v1/task/ZMP9nlweSZ2bNNrwCzRWcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:16:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMP9nlweSZ2bNNrwCzRWcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:16:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMP9nlweSZ2bNNrwCzRWcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:16:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMP9nlweSZ2bNNrwCzRWcw/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 18:16:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMP9nlweSZ2bNNrwCzRWcw/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 18:16:25 INFO - Downloaded 22757638 bytes. 18:16:25 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'] 18:16:25 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 18:16:26 INFO - Return code: 0 18:16:26 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')]} 18:16:26 INFO - https://queue.taskcluster.net/v1/task/ZMP9nlweSZ2bNNrwCzRWcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:16:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMP9nlweSZ2bNNrwCzRWcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:16:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMP9nlweSZ2bNNrwCzRWcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:16:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMP9nlweSZ2bNNrwCzRWcw/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 18:16:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMP9nlweSZ2bNNrwCzRWcw/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 18:16:27 INFO - Downloaded 14403317 bytes. 18:16:27 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'] 18:16:27 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 18:16:28 INFO - Return code: 0 18:16:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:28 INFO - https://queue.taskcluster.net/v1/task/ZMP9nlweSZ2bNNrwCzRWcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:16:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMP9nlweSZ2bNNrwCzRWcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:16:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMP9nlweSZ2bNNrwCzRWcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:16:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMP9nlweSZ2bNNrwCzRWcw/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 18:16:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZMP9nlweSZ2bNNrwCzRWcw/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 18:16:29 INFO - Downloaded 57079059 bytes. 18:16:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZMP9nlweSZ2bNNrwCzRWcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:16:29 INFO - mkdir: /builds/slave/test/properties 18:16:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:16:29 INFO - Writing to file /builds/slave/test/properties/build_url 18:16:29 INFO - Contents: 18:16:29 INFO - build_url:https://queue.taskcluster.net/v1/task/ZMP9nlweSZ2bNNrwCzRWcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:16:30 INFO - Running post-action listener: _resource_record_post_action 18:16:30 INFO - Running post-action listener: set_extra_try_arguments 18:16:30 INFO - ##### 18:16:30 INFO - ##### Finished download-and-extract step (success) 18:16:30 INFO - ##### 18:16:30 INFO - ##### 18:16:30 INFO - ##### Running populate-webroot step. 18:16:30 INFO - ##### 18:16:30 INFO - Running pre-action listener: _resource_record_pre_action 18:16:30 INFO - Running main action method: populate_webroot 18:16:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:16:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:16:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:16:30 INFO - '--tppagecycles', 18:16:30 INFO - '7'], 18:16:30 INFO - 'tests': ['tsvgm']}}, 18:16:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:16:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:16:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:16:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:16:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:16:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:16:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:16:30 INFO - 'talos_options': ['--disable-e10s'], 18:16:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:16:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:16:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:16:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:16:30 INFO - 'talos_options': ['--disable-e10s'], 18:16:30 INFO - 'tests': ['damp', 'tps']}, 18:16:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:16:30 INFO - 'tests': ['damp', 'tps']}, 18:16:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:16:30 INFO - 'tests': ['dromaeo_dom']}, 18:16:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:16:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:16:30 INFO - 'tests': ['basic_compositor_video']}, 18:16:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:16:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:16:30 INFO - 'tests': ['a11yr', 18:16:30 INFO - 'ts_paint', 18:16:30 INFO - 'tpaint', 18:16:30 INFO - 'sessionrestore', 18:16:30 INFO - 'sessionrestore_no_auto_restore', 18:16:30 INFO - 'tabpaint']}, 18:16:30 INFO - 'other-e10s': {'tests': ['a11yr', 18:16:30 INFO - 'ts_paint', 18:16:30 INFO - 'tpaint', 18:16:30 INFO - 'sessionrestore', 18:16:30 INFO - 'sessionrestore_no_auto_restore', 18:16:30 INFO - 'tabpaint']}, 18:16:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:16:30 INFO - 'ts_paint', 18:16:30 INFO - 'tpaint', 18:16:30 INFO - 'sessionrestore', 18:16:30 INFO - 'sessionrestore_no_auto_restore', 18:16:30 INFO - 'tabpaint']}, 18:16:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:16:30 INFO - 'ts_paint', 18:16:30 INFO - 'tpaint', 18:16:30 INFO - 'sessionrestore', 18:16:30 INFO - 'sessionrestore_no_auto_restore', 18:16:30 INFO - 'tabpaint']}, 18:16:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:16:30 INFO - 'tests': ['a11yr', 18:16:30 INFO - 'ts_paint', 18:16:30 INFO - 'tpaint', 18:16:30 INFO - 'sessionrestore', 18:16:30 INFO - 'sessionrestore_no_auto_restore', 18:16:30 INFO - 'tabpaint']}, 18:16:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:16:30 INFO - 'tests': ['a11yr', 18:16:30 INFO - 'ts_paint', 18:16:30 INFO - 'tpaint', 18:16:30 INFO - 'sessionrestore', 18:16:30 INFO - 'sessionrestore_no_auto_restore', 18:16:30 INFO - 'tabpaint']}, 18:16:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:16:30 INFO - 'tests': ['tsvgx', 18:16:30 INFO - 'tsvgr_opacity', 18:16:30 INFO - 'tart', 18:16:30 INFO - 'tscrollx', 18:16:30 INFO - 'cart']}, 18:16:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:16:30 INFO - 'tsvgr_opacity', 18:16:30 INFO - 'tart', 18:16:30 INFO - 'tscrollx', 18:16:30 INFO - 'cart']}, 18:16:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:16:30 INFO - 'talos_options': ['--disable-e10s'], 18:16:30 INFO - 'tests': ['tp5o']}, 18:16:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:16:30 INFO - 'tests': ['tp5o']}, 18:16:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:16:30 INFO - 'talos_options': ['--disable-e10s', 18:16:30 INFO - '--xperf_path', 18:16:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:16:30 INFO - 'tests': ['tp5n']}, 18:16:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:16:30 INFO - 'talos_options': ['--xperf_path', 18:16:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:16:30 INFO - 'tests': ['tp5n']}}, 18:16:30 INFO - 'talos.zip': {'path': '', 18:16:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:16:30 INFO - Running post-action listener: _resource_record_post_action 18:16:30 INFO - ##### 18:16:30 INFO - ##### Finished populate-webroot step (success) 18:16:30 INFO - ##### 18:16:30 INFO - ##### 18:16:30 INFO - ##### Running create-virtualenv step. 18:16:30 INFO - ##### 18:16:30 INFO - Running pre-action listener: _resource_record_pre_action 18:16:30 INFO - Running main action method: create_virtualenv 18:16:30 INFO - Creating virtualenv /builds/slave/test/build/venv 18:16:30 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 18:16:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:16:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:16:30 INFO - Using real prefix '/usr' 18:16:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:16:30 INFO - Installing distribute.............................................................................................................................................................................................done. 18:16:32 INFO - Installing pip.................done. 18:16:32 INFO - Return code: 0 18:16:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:16:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:16:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:32 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 0x298c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bbb400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c4a570>, '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 0x2c4b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c4b900>, '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': 'a0d2d2de893abaa8702a9954000001a7-1468631021.344905-55548007', '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 18:16:32 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 18:16:32 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 18:16:32 INFO - Using env: {'DISPLAY': ':0', 18:16:32 INFO - 'HOME': '/home/cltbld', 18:16:32 INFO - 'LANG': 'en_US.UTF-8', 18:16:32 INFO - 'LANGUAGE': 'en_US:en', 18:16:32 INFO - 'LOGNAME': 'cltbld', 18:16:32 INFO - 'MAIL': '/var/mail/cltbld', 18:16:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:32 INFO - 'MOZ_NO_REMOTE': '1', 18:16:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:16:32 INFO - 'NO_EM_RESTART': '1', 18:16:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:16:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:16:32 INFO - 'PWD': '/builds/slave/test', 18:16:32 INFO - 'SHELL': '/bin/bash', 18:16:32 INFO - 'SHLVL': '1', 18:16:32 INFO - 'TERM': 'linux', 18:16:32 INFO - 'TMOUT': '86400', 18:16:32 INFO - 'USER': 'cltbld', 18:16:32 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1468631021.344905-55548007', 18:16:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:32 INFO - '_': '/tools/buildbot/bin/python'} 18:16:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:16:33 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 18:16:33 INFO - Cleaning up... 18:16:33 INFO - Return code: 0 18:16:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:16:33 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')]} 18:16:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:16:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:33 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')]} 18:16:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:16:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:33 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 0x298c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bbb400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c4a570>, '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 0x2c4b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c4b900>, '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': 'a0d2d2de893abaa8702a9954000001a7-1468631021.344905-55548007', '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 18:16:33 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 18:16:33 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 18:16:33 INFO - Using env: {'DISPLAY': ':0', 18:16:33 INFO - 'HOME': '/home/cltbld', 18:16:33 INFO - 'LANG': 'en_US.UTF-8', 18:16:33 INFO - 'LANGUAGE': 'en_US:en', 18:16:33 INFO - 'LOGNAME': 'cltbld', 18:16:33 INFO - 'MAIL': '/var/mail/cltbld', 18:16:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:33 INFO - 'MOZ_NO_REMOTE': '1', 18:16:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:16:33 INFO - 'NO_EM_RESTART': '1', 18:16:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:16:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:16:33 INFO - 'PWD': '/builds/slave/test', 18:16:33 INFO - 'SHELL': '/bin/bash', 18:16:33 INFO - 'SHLVL': '1', 18:16:33 INFO - 'TERM': 'linux', 18:16:33 INFO - 'TMOUT': '86400', 18:16:33 INFO - 'USER': 'cltbld', 18:16:33 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1468631021.344905-55548007', 18:16:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:33 INFO - '_': '/tools/buildbot/bin/python'} 18:16:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:16:33 INFO - Downloading/unpacking psutil>=3.1.1 18:16:33 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 18:16:33 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 18:16:33 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 18:16:33 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 18:16:33 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 18:16:33 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 18:16:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:16:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:16:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:16:35 INFO - Installing collected packages: psutil 18:16:35 INFO - Running setup.py install for psutil 18:16:35 INFO - building 'psutil._psutil_linux' extension 18:16:35 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 18:16:36 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 18:16:36 INFO - building 'psutil._psutil_posix' extension 18:16:36 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 18:16:36 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 18:16:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:16:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:16:37 INFO - Successfully installed psutil 18:16:37 INFO - Cleaning up... 18:16:37 INFO - Return code: 0 18:16:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:16:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:16:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:16:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:37 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 0x298c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bbb400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c4a570>, '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 0x2c4b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c4b900>, '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': 'a0d2d2de893abaa8702a9954000001a7-1468631021.344905-55548007', '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 18:16:37 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 18:16:37 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 18:16:37 INFO - Using env: {'DISPLAY': ':0', 18:16:37 INFO - 'HOME': '/home/cltbld', 18:16:37 INFO - 'LANG': 'en_US.UTF-8', 18:16:37 INFO - 'LANGUAGE': 'en_US:en', 18:16:37 INFO - 'LOGNAME': 'cltbld', 18:16:37 INFO - 'MAIL': '/var/mail/cltbld', 18:16:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:37 INFO - 'MOZ_NO_REMOTE': '1', 18:16:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:16:37 INFO - 'NO_EM_RESTART': '1', 18:16:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:16:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:16:37 INFO - 'PWD': '/builds/slave/test', 18:16:37 INFO - 'SHELL': '/bin/bash', 18:16:37 INFO - 'SHLVL': '1', 18:16:37 INFO - 'TERM': 'linux', 18:16:37 INFO - 'TMOUT': '86400', 18:16:37 INFO - 'USER': 'cltbld', 18:16:37 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1468631021.344905-55548007', 18:16:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:37 INFO - '_': '/tools/buildbot/bin/python'} 18:16:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:16:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:16:37 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 18:16:37 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 18:16:37 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 18:16:37 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 18:16:37 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 18:16:37 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 18:16:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:16:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:16:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:16:39 INFO - Installing collected packages: mozsystemmonitor 18:16:39 INFO - Running setup.py install for mozsystemmonitor 18:16:39 INFO - Successfully installed mozsystemmonitor 18:16:39 INFO - Cleaning up... 18:16:39 INFO - Return code: 0 18:16:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:16:39 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')]} 18:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:16:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:39 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')]} 18:16:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:16:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:39 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 0x298c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bbb400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c4a570>, '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 0x2c4b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c4b900>, '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': 'a0d2d2de893abaa8702a9954000001a7-1468631021.344905-55548007', '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 18:16:39 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 18:16:39 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 18:16:39 INFO - Using env: {'DISPLAY': ':0', 18:16:39 INFO - 'HOME': '/home/cltbld', 18:16:39 INFO - 'LANG': 'en_US.UTF-8', 18:16:39 INFO - 'LANGUAGE': 'en_US:en', 18:16:39 INFO - 'LOGNAME': 'cltbld', 18:16:39 INFO - 'MAIL': '/var/mail/cltbld', 18:16:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:39 INFO - 'MOZ_NO_REMOTE': '1', 18:16:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:16:39 INFO - 'NO_EM_RESTART': '1', 18:16:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:16:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:16:39 INFO - 'PWD': '/builds/slave/test', 18:16:39 INFO - 'SHELL': '/bin/bash', 18:16:39 INFO - 'SHLVL': '1', 18:16:39 INFO - 'TERM': 'linux', 18:16:39 INFO - 'TMOUT': '86400', 18:16:39 INFO - 'USER': 'cltbld', 18:16:39 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1468631021.344905-55548007', 18:16:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:39 INFO - '_': '/tools/buildbot/bin/python'} 18:16:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:16:39 INFO - Downloading/unpacking jsonschema==2.5.1 18:16:39 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 18:16:39 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 18:16:39 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 18:16:39 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 18:16:39 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 18:16:39 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 18:16:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:16:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:16: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 18:16: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 18:16: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 18:16: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 18:16: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 18:16: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 18:16:41 INFO - Downloading functools32-3.2.3-2.tar.gz 18:16:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:16:41 INFO - warning: no files found matching '*.txt' 18:16:41 INFO - no previously-included directories found matching 'build' 18:16:41 INFO - no previously-included directories found matching 'dist' 18:16:41 INFO - no previously-included directories found matching '.git*' 18:16:41 INFO - Installing collected packages: jsonschema, functools32 18:16:41 INFO - Running setup.py install for functools32 18:16:41 INFO - warning: no files found matching '*.txt' 18:16:41 INFO - no previously-included directories found matching 'build' 18:16:41 INFO - no previously-included directories found matching 'dist' 18:16:41 INFO - no previously-included directories found matching '.git*' 18:16:41 INFO - Successfully installed jsonschema functools32 18:16:41 INFO - Cleaning up... 18:16:42 INFO - Return code: 0 18:16:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:16:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:16:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:16:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:42 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 0x298c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bbb400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c4a570>, '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 0x2c4b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c4b900>, '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': 'a0d2d2de893abaa8702a9954000001a7-1468631021.344905-55548007', '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 18:16:42 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 18:16:42 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 18:16:42 INFO - Using env: {'DISPLAY': ':0', 18:16:42 INFO - 'HOME': '/home/cltbld', 18:16:42 INFO - 'LANG': 'en_US.UTF-8', 18:16:42 INFO - 'LANGUAGE': 'en_US:en', 18:16:42 INFO - 'LOGNAME': 'cltbld', 18:16:42 INFO - 'MAIL': '/var/mail/cltbld', 18:16:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:42 INFO - 'MOZ_NO_REMOTE': '1', 18:16:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:16:42 INFO - 'NO_EM_RESTART': '1', 18:16:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:16:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:16:42 INFO - 'PWD': '/builds/slave/test', 18:16:42 INFO - 'SHELL': '/bin/bash', 18:16:42 INFO - 'SHLVL': '1', 18:16:42 INFO - 'TERM': 'linux', 18:16:42 INFO - 'TMOUT': '86400', 18:16:42 INFO - 'USER': 'cltbld', 18:16:42 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1468631021.344905-55548007', 18:16:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:42 INFO - '_': '/tools/buildbot/bin/python'} 18:16:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:16:42 INFO - Downloading/unpacking blobuploader==1.2.4 18:16:42 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 18:16:42 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 18:16:42 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 18:16:42 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 18:16:42 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 18:16:42 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 18:16:44 INFO - Downloading blobuploader-1.2.4.tar.gz 18:16:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:16:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:16:44 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 18:16:44 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 18:16:44 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 18:16:44 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 18:16:44 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 18:16:44 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 18:16:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:16:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:16:44 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 18:16:44 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 18:16:44 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 18:16:44 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 18:16:44 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 18:16:44 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 18:16:45 INFO - Downloading docopt-0.6.1.tar.gz 18:16:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:16:45 INFO - Installing collected packages: blobuploader, requests, docopt 18:16:45 INFO - Running setup.py install for blobuploader 18:16:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:16:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:16:45 INFO - Running setup.py install for requests 18:16:45 INFO - Running setup.py install for docopt 18:16:45 INFO - Successfully installed blobuploader requests docopt 18:16:45 INFO - Cleaning up... 18:16:45 INFO - Return code: 0 18:16:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:16:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:16:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:16:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:45 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 0x298c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bbb400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c4a570>, '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 0x2c4b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c4b900>, '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': 'a0d2d2de893abaa8702a9954000001a7-1468631021.344905-55548007', '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 18:16:45 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 18:16:45 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 18:16:45 INFO - Using env: {'DISPLAY': ':0', 18:16:45 INFO - 'HOME': '/home/cltbld', 18:16:45 INFO - 'LANG': 'en_US.UTF-8', 18:16:45 INFO - 'LANGUAGE': 'en_US:en', 18:16:45 INFO - 'LOGNAME': 'cltbld', 18:16:45 INFO - 'MAIL': '/var/mail/cltbld', 18:16:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:45 INFO - 'MOZ_NO_REMOTE': '1', 18:16:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:16:45 INFO - 'NO_EM_RESTART': '1', 18:16:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:16:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:16:45 INFO - 'PWD': '/builds/slave/test', 18:16:45 INFO - 'SHELL': '/bin/bash', 18:16:45 INFO - 'SHLVL': '1', 18:16:45 INFO - 'TERM': 'linux', 18:16:45 INFO - 'TMOUT': '86400', 18:16:45 INFO - 'USER': 'cltbld', 18:16:45 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1468631021.344905-55548007', 18:16:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:45 INFO - '_': '/tools/buildbot/bin/python'} 18:16:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:16:45 INFO - Running setup.py (path:/tmp/pip-9fvq4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:16:45 INFO - Running setup.py (path:/tmp/pip-IpvWdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:16:46 INFO - Running setup.py (path:/tmp/pip-0dRxR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:16:46 INFO - Running setup.py (path:/tmp/pip-1FP_vr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:16:46 INFO - Running setup.py (path:/tmp/pip-pUOxJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:16:46 INFO - Running setup.py (path:/tmp/pip-RfvJ8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:16:46 INFO - Running setup.py (path:/tmp/pip-X1jUEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:16:46 INFO - Running setup.py (path:/tmp/pip-v1uSzK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:16:46 INFO - Running setup.py (path:/tmp/pip-CMl8Xu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:16:46 INFO - Running setup.py (path:/tmp/pip-4Xq9K5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:16:46 INFO - Running setup.py (path:/tmp/pip-PFTWMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:16:46 INFO - Running setup.py (path:/tmp/pip-fHaozW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:16:46 INFO - Running setup.py (path:/tmp/pip-MMaYOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:16:46 INFO - Running setup.py (path:/tmp/pip-LLG44v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:16:46 INFO - Running setup.py (path:/tmp/pip-bMGHPt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:16:47 INFO - Running setup.py (path:/tmp/pip-_5v6nu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:16:47 INFO - Running setup.py (path:/tmp/pip-wSlvzs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:16:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:16:47 INFO - Running setup.py install for manifestparser 18:16:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:16:47 INFO - Running setup.py install for mozcrash 18:16:47 INFO - Running setup.py install for mozdebug 18:16:47 INFO - Running setup.py install for mozdevice 18:16:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:16:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:16:47 INFO - Running setup.py install for mozfile 18:16:47 INFO - Running setup.py install for mozhttpd 18:16:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:16:47 INFO - Running setup.py install for mozinfo 18:16:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:16:47 INFO - Running setup.py install for mozInstall 18:16:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:16:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:16:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:16:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:16:47 INFO - Running setup.py install for mozleak 18:16:48 INFO - Running setup.py install for mozlog 18:16:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:16:48 INFO - Running setup.py install for moznetwork 18:16:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:16:48 INFO - Running setup.py install for mozprocess 18:16:48 INFO - Running setup.py install for mozprofile 18:16:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:16:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:16:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:16:48 INFO - Running setup.py install for mozrunner 18:16:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:16:48 INFO - Running setup.py install for mozscreenshot 18:16:48 INFO - Running setup.py install for moztest 18:16:48 INFO - Running setup.py install for mozversion 18:16:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:16:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:16:48 INFO - Cleaning up... 18:16:48 INFO - Return code: 0 18:16:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:16:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:16:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:16:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:48 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 0x298c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bbb400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c4a570>, '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 0x2c4b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c4b900>, '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': 'a0d2d2de893abaa8702a9954000001a7-1468631021.344905-55548007', '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 18:16:48 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 18:16:48 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 18:16:48 INFO - Using env: {'DISPLAY': ':0', 18:16:48 INFO - 'HOME': '/home/cltbld', 18:16:48 INFO - 'LANG': 'en_US.UTF-8', 18:16:48 INFO - 'LANGUAGE': 'en_US:en', 18:16:48 INFO - 'LOGNAME': 'cltbld', 18:16:48 INFO - 'MAIL': '/var/mail/cltbld', 18:16:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:48 INFO - 'MOZ_NO_REMOTE': '1', 18:16:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:16:48 INFO - 'NO_EM_RESTART': '1', 18:16:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:16:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:16:48 INFO - 'PWD': '/builds/slave/test', 18:16:48 INFO - 'SHELL': '/bin/bash', 18:16:48 INFO - 'SHLVL': '1', 18:16:48 INFO - 'TERM': 'linux', 18:16:48 INFO - 'TMOUT': '86400', 18:16:48 INFO - 'USER': 'cltbld', 18:16:48 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1468631021.344905-55548007', 18:16:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:48 INFO - '_': '/tools/buildbot/bin/python'} 18:16:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:16:49 INFO - Running setup.py (path:/tmp/pip-gSeaIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:16:49 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)) 18:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:16:49 INFO - Running setup.py (path:/tmp/pip-IaEi6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:16:49 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)) 18:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:16:49 INFO - Running setup.py (path:/tmp/pip-lXpALE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:16:49 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)) 18:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:16:49 INFO - Running setup.py (path:/tmp/pip-72nmBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:16:49 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)) 18:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:16:49 INFO - Running setup.py (path:/tmp/pip-oNJ7bm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:16:49 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)) 18:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:16:49 INFO - Running setup.py (path:/tmp/pip-AAveuV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:16:49 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)) 18:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:16:49 INFO - Running setup.py (path:/tmp/pip-ToGJIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:16:49 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)) 18:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:16:49 INFO - Running setup.py (path:/tmp/pip-oKWg0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:16:49 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)) 18:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:16:49 INFO - Running setup.py (path:/tmp/pip-R1TvRw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:16:49 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)) 18:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:16:49 INFO - Running setup.py (path:/tmp/pip-xMS3aq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:16:49 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)) 18:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:16:49 INFO - Running setup.py (path:/tmp/pip-XBqBeC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:16:49 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)) 18:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:16:49 INFO - Running setup.py (path:/tmp/pip-8JIla1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:16:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:16:50 INFO - Running setup.py (path:/tmp/pip-HupzC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:16:50 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)) 18:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:16:50 INFO - Running setup.py (path:/tmp/pip-n1rAs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:16:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:16:50 INFO - Running setup.py (path:/tmp/pip-ZXDbGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:16:50 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)) 18:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:16:50 INFO - Running setup.py (path:/tmp/pip-nPg7hy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:16:50 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)) 18:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:16:50 INFO - Running setup.py (path:/tmp/pip-wD1tap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:16:50 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)) 18:16:50 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)) 18:16:50 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)) 18:16:50 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)) 18:16:50 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)) 18:16:50 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)) 18:16:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:52 INFO - Downloading blessings-1.6.tar.gz 18:16:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:16:52 INFO - Installing collected packages: blessings 18:16:52 INFO - Running setup.py install for blessings 18:16:52 INFO - Successfully installed blessings 18:16:52 INFO - Cleaning up... 18:16:52 INFO - Return code: 0 18:16:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:16:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:16:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:16:52 INFO - Reading from file tmpfile_stdout 18:16:52 INFO - Current package versions: 18:16:52 INFO - argparse == 1.2.1 18:16:52 INFO - blessings == 1.6 18:16:52 INFO - blobuploader == 1.2.4 18:16:52 INFO - docopt == 0.6.1 18:16:52 INFO - functools32 == 3.2.3-2 18:16:52 INFO - jsonschema == 2.5.1 18:16:52 INFO - manifestparser == 1.1 18:16:52 INFO - mozInstall == 1.12 18:16:52 INFO - mozcrash == 0.17 18:16:52 INFO - mozdebug == 0.1 18:16:52 INFO - mozdevice == 0.48 18:16:52 INFO - mozfile == 1.2 18:16:52 INFO - mozhttpd == 0.7 18:16:52 INFO - mozinfo == 0.9 18:16:52 INFO - mozleak == 0.1 18:16:52 INFO - mozlog == 3.2 18:16:52 INFO - moznetwork == 0.27 18:16:52 INFO - mozprocess == 0.23 18:16:52 INFO - mozprofile == 0.28 18:16:52 INFO - mozrunner == 6.12 18:16:52 INFO - mozscreenshot == 0.1 18:16:52 INFO - mozsystemmonitor == 0.3 18:16:52 INFO - moztest == 0.7 18:16:52 INFO - mozversion == 1.4 18:16:52 INFO - psutil == 3.1.1 18:16:52 INFO - requests == 1.2.3 18:16:52 INFO - wsgiref == 0.1.2 18:16:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:16: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')]} 18:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:16:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16: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')]} 18:16:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:16:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:52 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 0x298c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bbb400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c4a570>, '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 0x2c4b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c4b900>, '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': 'a0d2d2de893abaa8702a9954000001a7-1468631021.344905-55548007', '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 18:16:52 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 18:16:52 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 18:16:52 INFO - Using env: {'DISPLAY': ':0', 18:16:52 INFO - 'HOME': '/home/cltbld', 18:16:52 INFO - 'LANG': 'en_US.UTF-8', 18:16:52 INFO - 'LANGUAGE': 'en_US:en', 18:16:52 INFO - 'LOGNAME': 'cltbld', 18:16:52 INFO - 'MAIL': '/var/mail/cltbld', 18:16:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:52 INFO - 'MOZ_NO_REMOTE': '1', 18:16:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:16:52 INFO - 'NO_EM_RESTART': '1', 18:16:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:16:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:16:52 INFO - 'PWD': '/builds/slave/test', 18:16:52 INFO - 'SHELL': '/bin/bash', 18:16:52 INFO - 'SHLVL': '1', 18:16:52 INFO - 'TERM': 'linux', 18:16:52 INFO - 'TMOUT': '86400', 18:16:52 INFO - 'USER': 'cltbld', 18:16:52 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1468631021.344905-55548007', 18:16:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:52 INFO - '_': '/tools/buildbot/bin/python'} 18:16:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:16:52 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)) 18:16:52 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)) 18:16:52 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)) 18:16:52 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)) 18:16:52 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)) 18:16:52 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)) 18:16:52 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)) 18:16:52 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)) 18:16:52 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)) 18:16:52 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)) 18:16:52 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)) 18:16:52 INFO - Cleaning up... 18:16:53 INFO - Return code: 0 18:16:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:16:53 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')]} 18:16:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:16:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:53 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')]} 18:16:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:16:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:53 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 0x298c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bbb400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c4a570>, '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 0x2c4b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c4b900>, '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': 'a0d2d2de893abaa8702a9954000001a7-1468631021.344905-55548007', '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 18:16:53 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 18:16:53 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 18:16:53 INFO - Using env: {'DISPLAY': ':0', 18:16:53 INFO - 'HOME': '/home/cltbld', 18:16:53 INFO - 'LANG': 'en_US.UTF-8', 18:16:53 INFO - 'LANGUAGE': 'en_US:en', 18:16:53 INFO - 'LOGNAME': 'cltbld', 18:16:53 INFO - 'MAIL': '/var/mail/cltbld', 18:16:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:53 INFO - 'MOZ_NO_REMOTE': '1', 18:16:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:16:53 INFO - 'NO_EM_RESTART': '1', 18:16:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:16:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:16:53 INFO - 'PWD': '/builds/slave/test', 18:16:53 INFO - 'SHELL': '/bin/bash', 18:16:53 INFO - 'SHLVL': '1', 18:16:53 INFO - 'TERM': 'linux', 18:16:53 INFO - 'TMOUT': '86400', 18:16:53 INFO - 'USER': 'cltbld', 18:16:53 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1468631021.344905-55548007', 18:16:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:53 INFO - '_': '/tools/buildbot/bin/python'} 18:16:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:16:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:16:53 INFO - Cleaning up... 18:16:53 INFO - Return code: 0 18:16:53 INFO - Running post-action listener: _resource_record_post_action 18:16:53 INFO - Running post-action listener: _start_resource_monitoring 18:16:53 INFO - Starting resource monitoring. 18:16:53 INFO - ##### 18:16:53 INFO - ##### Finished create-virtualenv step (success) 18:16:53 INFO - ##### 18:16:53 INFO - ##### 18:16:53 INFO - ##### Running install step. 18:16:53 INFO - ##### 18:16:53 INFO - Running pre-action listener: _resource_record_pre_action 18:16:53 INFO - Running main action method: install 18:16:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:16:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:16:53 INFO - Reading from file tmpfile_stdout 18:16:53 INFO - Detecting whether we're running mozinstall >=1.0... 18:16:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:16:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:16:53 INFO - Reading from file tmpfile_stdout 18:16:53 INFO - Output received: 18:16:53 INFO - Usage: mozinstall [options] installer 18:16:53 INFO - Options: 18:16:53 INFO - -h, --help show this help message and exit 18:16:53 INFO - -d DEST, --destination=DEST 18:16:53 INFO - Directory to install application into. [default: 18:16:53 INFO - "/builds/slave/test"] 18:16:53 INFO - --app=APP Application being installed. [default: firefox] 18:16:53 INFO - mkdir: /builds/slave/test/build/application 18:16:53 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'] 18:16:53 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 18:17:09 INFO - Reading from file tmpfile_stdout 18:17:09 INFO - Output received: 18:17:09 INFO - /builds/slave/test/build/application/firefox/firefox 18:17:09 INFO - Running post-action listener: _resource_record_post_action 18:17:09 INFO - ##### 18:17:09 INFO - ##### Finished install step (success) 18:17:09 INFO - ##### 18:17:09 INFO - ##### 18:17:09 INFO - ##### Running run-tests step. 18:17:09 INFO - ##### 18:17:09 INFO - Running pre-action listener: _resource_record_pre_action 18:17:09 INFO - Running main action method: run_tests 18:17:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:17:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:17:09 INFO - Python 2.7.3 18:17:09 INFO - Return code: 0 18:17:09 INFO - grabbing minidump binary from tooltool 18:17:09 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')]} 18:17:09 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 0x2c4a570>, '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 0x2c4b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c4b900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:17:09 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 18:17:09 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 18:17:09 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 18:17:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:17:10 INFO - Return code: 0 18:17:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:17:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:17:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:17:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:17:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:17:10 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZMP9nlweSZ2bNNrwCzRWcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:17:10 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZMP9nlweSZ2bNNrwCzRWcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:17:10 INFO - Using env: {'DISPLAY': ':0', 18:17:10 INFO - 'HOME': '/home/cltbld', 18:17:10 INFO - 'LANG': 'en_US.UTF-8', 18:17:10 INFO - 'LANGUAGE': 'en_US:en', 18:17:10 INFO - 'LOGNAME': 'cltbld', 18:17:10 INFO - 'MAIL': '/var/mail/cltbld', 18:17:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:17:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:17:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:10 INFO - 'MOZ_NO_REMOTE': '1', 18:17:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:17:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:17:10 INFO - 'NO_EM_RESTART': '1', 18:17:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:17:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:10 INFO - 'PWD': '/builds/slave/test', 18:17:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:17:10 INFO - 'SHELL': '/bin/bash', 18:17:10 INFO - 'SHLVL': '1', 18:17:10 INFO - 'TERM': 'linux', 18:17:10 INFO - 'TMOUT': '86400', 18:17:10 INFO - 'USER': 'cltbld', 18:17:10 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1468631021.344905-55548007', 18:17:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:10 INFO - '_': '/tools/buildbot/bin/python'} 18:17:10 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZMP9nlweSZ2bNNrwCzRWcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:17:10 INFO - mozversion application_buildid: 20160715170151 18:17:10 INFO - mozversion application_changeset: 0c27d48b278dba5493f9c98581acfd71889f7b63 18:17:10 INFO - mozversion application_display_name: Nightly 18:17:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:17:10 INFO - mozversion application_name: Firefox 18:17:10 INFO - mozversion application_remotingname: firefox 18:17:10 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:17:10 INFO - mozversion application_vendor: Mozilla 18:17:10 INFO - mozversion application_version: 50.0a1 18:17:10 INFO - mozversion platform_buildid: 20160715170151 18:17:10 INFO - mozversion platform_changeset: 0c27d48b278dba5493f9c98581acfd71889f7b63 18:17:10 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:17:10 INFO - mozversion platform_version: 50.0a1 18:17:10 INFO - using testdate: 1468631830 18:17:10 INFO - actual date: 1468631830 18:17:10 INFO - starting webserver on 'localhost:33766' 18:17:10 INFO - SUITE-START | Running 2 tests 18:17:10 INFO - TEST-START | dromaeo_css 18:17:10 INFO - operating with platform_type : linux_ 18:17:10 INFO - Initialising browser for dromaeo_css test... 18:17:10 INFO - TEST-INFO | started process 3281 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH4LD6y/profile http://localhost:33766/getInfo.html) 18:17:16 INFO - PROCESS | 3281 | __metrics Screen width/height:1600/1200 18:17:16 INFO - PROCESS | 3281 | colorDepth:24 18:17:16 INFO - PROCESS | 3281 | Browser inner width/height: 1024/697 18:17:16 INFO - PROCESS | 3281 | __metrics 18:17:17 ERROR - PROCESS | 3281 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 18:17:18 INFO - TEST-INFO | 3281: exit 0 18:17:18 INFO - Browser initialized. 18:17:18 INFO - Running cycle 1/1 for dromaeo_css test... 18:17:18 INFO - TEST-INFO | started process 3402 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH4LD6y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:17:30 INFO - PROCESS | 3402 | RSS: Main: 169013248 18:17:30 INFO - PROCESS | 3402 | 18:18:19 INFO - PROCESS | 3402 | 1468631899698 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] 18:20:31 INFO - PROCESS | 3402 | Cycle 1(1): loaded http://localhost:33766/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33766/tests/dromaeo/cssquery-ext.html) 18:20:32 INFO - PROCESS | 3402 | RSS: Main: 170217472 18:20:32 INFO - PROCESS | 3402 | 18:23:35 INFO - PROCESS | 3402 | Cycle 1(1): loaded http://localhost:33766/tests/dromaeo/cssquery-ext.html (next: http://localhost:33766/tests/dromaeo/cssquery-jquery.html) 18:23:35 INFO - PROCESS | 3402 | RSS: Main: 169848832 18:23:35 INFO - PROCESS | 3402 | 18:26:37 INFO - PROCESS | 3402 | Cycle 1(1): loaded http://localhost:33766/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33766/tests/dromaeo/cssquery-mootools.html) 18:26:38 INFO - PROCESS | 3402 | RSS: Main: 172978176 18:26:38 INFO - PROCESS | 3402 | 18:29:40 INFO - PROCESS | 3402 | Cycle 1(1): loaded http://localhost:33766/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33766/tests/dromaeo/cssquery-prototype.html) 18:29:40 INFO - PROCESS | 3402 | RSS: Main: 167596032 18:29:40 INFO - PROCESS | 3402 | 18:32:43 INFO - PROCESS | 3402 | Cycle 1(1): loaded http://localhost:33766/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33766/tests/dromaeo/cssquery-yui.html) 18:32:44 INFO - PROCESS | 3402 | RSS: Main: 169201664 18:32:44 INFO - PROCESS | 3402 | 18:35:47 INFO - PROCESS | 3402 | Cycle 1(1): loaded http://localhost:33766/tests/dromaeo/cssquery-yui.html (next: http://localhost:33766/tests/dromaeo/cssquery-dojo.html) 18:35:47 INFO - PROCESS | 3402 | RSS: Main: 170393600 18:35:47 INFO - PROCESS | 3402 | 18:35:47 INFO - PROCESS | 3402 | __start_tp_report 18:35:47 INFO - PROCESS | 3402 | _x_x_mozilla_page_load 18:35:47 INFO - PROCESS | 3402 | _x_x_mozilla_page_load_details 18:35:47 INFO - PROCESS | 3402 | |i|pagename|runs| 18:35:47 INFO - PROCESS | 3402 | |0;dojo.html;2625.632411462396;2634.815562910596;2644.418227989844;2655;2674.4784766970447;4792.472827988923;4798.568128868405;4869.123557759602;4870.975645121778;4887.340209071775;4806.279058141281;4821.54195351441;4873.610111191105;4920;4936.901261974758;4488.528704486022;4498.482674492426;4600.332951721998;4617.353570500132;4637.373954516131;417.8723371723665;4392.29723244281;4415.735055896656;4506.166359223538;4536.5236650151755;4460.888477788065;4509.526499717548;4519.683622146451;4540.091981603692;4572.702774319692;4537.251353526664;4562.794674239667;4566.748828814414;4574.9542504574865;4599.195140850371;4385.780710964471;4452.777361131931;4472.664550158751;4527.411436513232;4539.024109816405;4846.927296090562;4904.53406926345;4916.852494425173;4936.284238785356;4995.425526064513;5002.424721157077;5270.525652691276;5274.815381461669;5300.178472336794;5326.414094449608;5243.8164664236565;5287.920681189786;5295.338082739658;5311.442298558673;5330.840074797762;4945.777440015172;5008.799648014038;5014.674046186986;5027.572656324181;5072.492750724898;5250.711210883362;5280.419153893069;5467.808626698046;5501.559875209973;5502.504774570308;4996.650234483552;5084.644074914794;5090.516400941905;5095.541401273903;5149.562287205555;5148.536631703165;5156.071907056691;5189.818356357509;5195.220716892496;5200.2199670049795;5086.796528138907;5116.309298244763;5122.282880396748;5129.9230511542355;5269.657472264291;5066.620003499752;5073.670211436245;5095.286659867622;5113.411957624847;5155.7679904404395;4399.802008909543;4400.559944005638;4419.11617676466;4432.15789000089;4461.286194208911;3783.7162212834146;3822.8088595570666;3829.291581057513;3831.712621553339;3857.189990102054;4488.5960263576435;4515.300128480091;4517.299818528133;4537.160625284333;4600.378948841931;5236.031334203185;5255.132903071027;5268.104422248227;5285.920711189336;5320.308359913264;4401.207782599099;4424.292113261863;4442.800073996678;4452.109578084396;4452.376667266585;4615.123126605934;4651.837185698484;4655.115528049728;4665.253559430543;4709.199436095803;4809.038192361471;4836.806527738921;4845.466998630078;4879.634027447884;4886.755662216875;5289.41816400188;5341.973290133525;5368.1679339702405;5383.919241211307;5402.405735369185;4972.328735620645;4991.725455100004;4995.525425084611;5007.69953802773;5066.012127635223;4958;5022.899542009212;5277.630565860353;5290.232916227049;5295.364556253275;5108;5152.948470515247;5167.948320516897;5177;5223.686578805132;5014.222795466709;5026.120428924851;5028.120078986236;5033.421156567042;5090.08378491875;5001.174806157089;5023.748812559431;5037.924431133462;5139.434662187231;5167.483251674953;5074.695518268915;5078.289039534394;5086.313347698014;5135.3324067870935;5164.612654051037;5264.289320941624;5264.52619264268;5267.473252674702;5272.103742363731;5296.020236256305;4840.540148685869;4890.266460031024;4937.728424936663;4959.776810043629;5138.614603904797 18:35:47 INFO - PROCESS | 3402 | |1;ext.html;563.7942151114844;567.1945836911585;576.412059699107;582.2983305117334;611.0833749375936;34869.47695784562;39055;39127.608723912716;39171;39174.21651566974;39254;39753.20493590127;39827.60172398275;39882.20235595293;40011.59988400115;7710.691572337099;7776.53340799551;7844.2155784421675;7844.450888437783;7845.921540784605;7753.573553454557;7769;7836.490628109154;7849.411294152933;7856.72501462449;7797.376209903223;7843.686252549891;7853.5680537570415;7901.960490197541;7908.485948413363;7837.921620783804;7859.6463159157975;7862.606869656552;7868.803279917991;7887.645055972495;7712.807179820493;7728.961355193244;7775.261350171724;7790.727324543614;7807.414443916729;36836.63163368359;36959.63040369589;37111.628883711084;37269;37292.25415491702;2910.185148158519;2931.7361437470518;2949.852507374644;3156.8263745493987;3363.613184483767;29188.634813476172;29263.41473170525;29265.268368290963;29403.264918376997;29964.8501757492;3479.3215323012023;3511.0695665648623;3526.8236588170744;3541.8937431877084;3577.606463289036;254548;255166;256712;256750.71624641944;257672;52270.73864630653;52305.7384713074;52557.474425255255;52629;52699;32941.17647058843;33648.327033459194;33766;35683.643163568035;35686.46470302947;15418.229088545528;15472.226388680521;15526.844731552766;15571.84428155704;15653.452129175424;11762.294262344287;11850.229735067192;11861.11041671878;11902.107341949388;11908.821367679491;18132.274709011755;18308.993005384833;18338.724919126224;18356.357527486474;18380.17289221988;6804.081449004321;6840.657967101625;6876.209235937831;6967.268436814163;7006.2134155789945;837.9413441059189;849.7280870121501;906.3474298505066;922;978.256525040974;28337.858310708314;28980.565291520645;29235;29496.85251573771;29723.256918576775;933;966.246327864267;994.627014869424;1001.3140998416109;1004.5178314408978;14936.626584335261;15340.616484587974;15450.150241736812;15456.304466298818;15566.9221653891;379168;384710;385679;388222;392525;49413.50586494089;49441.50558494441;49650;49861.750691246314;50003.749981249865;1171.1918776044502;1199.0827017331749;1225.6568160914958;1225.914186006971;1228.6498347970964;27343.726562734915;28536.42927141404;28888.711112888603;29213.85393073021;29321.266968325963;43319.56680433155;46438.30342544932;48005.75997119992;48075.27887081627;53023.93952121013;352363;357823;358887;359263;359279;38649.80675096607;39033.414498781975;39035.21929561449;39066;39109.41335880021;42826.78586607047;42941.570584295005;43227.135457291304;43282.35076473792;44020;36733.26533469369;37314.62685373111;37361.25277494489;38063.61936380711;38371.6162838368;37388.813055934545;37557.4366384499;37737.81131094327;37866;38401.80799095987;31120.22199445032;35768.64231357757;37155;37207.813960931104;39274.2145157101;32148.19629509281;33375.83312083424;33808.448887456245;34425.31149377049;34465.48301775425;26177.607335889596;26350.86824565865;26413.33966650849;26436.735632644195;26659 18:35:47 INFO - PROCESS | 3402 | |2;jquery.html;375.8346327615849;378.66866491819655;380.30973782584607;394.6132789865931;394.7335548504762;16250.387294733795;17369.56576085597;17801.198946047425;18107.366242181528;18115;17070.48788536346;17097.145142742876;17326.653466930653;17659.64680706385;17668.911655441738;5160.3033590465275;5298.947010529903;5323.893522129555;5341.145416733323;5341.4925582069645;3791.6587507124354;5965.671888046156;6285.151504546873;6310.053491976194;6322.399372059647;6141.907871381911;6275.152854364648;6285.560010799246;6291.465225455819;6314.210723659543;6271;6290.056491526262;6297.275813281485;6304.716287767039;6325.4307112359875;5296.841094767163;5506.311711036121;5527.640703354309;5530.336359636829;5542.91685624716;20816.687749683766;21187.25844595447;21364.786352136434;21805.781942180532;21832.672509912365;1917.9424617261504;1993.7308463357406;2088.6658134698378;2140.9143634254765;2491.177911289288;13437.462501499927;13452.663683407993;13763.38064787087;13813.309334533233;13982.72034559303;1693.5935375509912;1791.7133258678548;1801.5406071451828;1837.366108692499;1872.2323847222574;69107.65446172787;71750.64124679395;71831.28168718299;72321.63839180823;72987.27012729857;9322.86015709765;9490.810183796286;9593.616255349847;9642.517874106266;9847.409155450552;13342.799858002138;13403.664908377174;13429.462821487226;13446.260455675032;13458.05793594439;7391.667374968032;7614.619269036526;7667.233276672399;7668.041494813148;7764.650590723431;7307.8538429232185;7400.259974002557;7509.62451877404;7627.961860190663;7640.541567505968;5464.180372944011;6105.32841387447;6212.192414986023;6221.346758590283;6227.439530442282;1694.432365157686;1789.6599646067205;1802.6484835457222;1820.8179182081685;1840.4478656403026;854.3634991931051;921.801812610292;956.3401253135314;983.5524836199512;1010.6210171185805;17325.22036508335;17431.128443578025;17578.824211757976;17810.821891781176;17981.730274045898;892.0900681305033;943.4009404028492;956.4739393333639;964.3731574476506;974.4932635029745;9258.861117083248;10193.592256309665;10309.53607087683;10318.742031449274;10471.214658900613;131988.3400582991;132213;132605.33697331644;132680;132862;66105;70348.64825675839;70668.64665676742;71025;72050;871.5250188647202;931.4737173496952;954.3891909178132;957.3681370295571;969.4813274897755;15904.76142857835;15934.28295726672;16124.919375403048;16238.918805405898;16418.67162656764;34590;35336.64663353334;36489.452658209615;37268.627313726516;38394.42408363933;54712;56298.71850640884;56445.71777141088;56597.15104273522;57301;7717.768466946;7844.84310313802;7886.921130788619;7889.566073865993;7904.051513818378;10419.479026048819;11458.312501249951;11977.580784672844;12282.75434491323;12564.560240391542;10007.349522281029;10424.739381515523;10476.738081548023;10706.839397408889;10899.182561307774;9784.9021509784;9977.950110249401;10076.244281678757;10250.948745256524;10476.109530689671;9435.254477921606;9531.332806703464;10036.598536058476;10127.442990635585;10342.224333175192;7887.40844436681;8082.595870206349;8233.547154906299;8257.752267431986;8270.421070525006;10146.949265253626;10584.89415105839;10769.838452423062;10794.784104318027;10861.945690271497 18:35:47 INFO - PROCESS | 3402 | |3;mootools.html;1390.944362225511;1434.6413396650837;1517.2337969325488;1719.742038694195;1727.5940154063792;7181.712731490734;7894.684212631495;7983.401244906626;8432.451890627104;8464.153584641534;8079.676812927491;8121.30968867647;8136.982877140357;8187.385946054055;8223.753287401372;2195.6596727507263;2234.6759719840616;2238.731352237726;2242.686023956647;2243.9775602244013;2158.363282831561;2197.571473562656;2231.9218827341047;2239.854409463388;2256.0411824974403;2190.102058156156;2212.037763572851;2218.170009741961;2220.433789383705;2225.276785044859;2173.7500187478486;2179.3353027326657;2180.749213840405;2189.6496560550236;2199.7690242524463;2123.108294516307;2136.529963408048;2160.9783902160934;2162.8702277863376;2165.069020321261;8051.677932882678;8132.064812546574;8135.918640813576;8153.30696890765;8187.918120818775;4689.8358557450665;4823.252395878644;4836.951630483685;4849.127157111719;4849.878753031167;2918.430905973336;2991.41667374862;2991.8354490503016;3030.4393687167944;3096.90709278722;887.7469921072463;901.8016036471965;925.5973651461636;929.8558723397884;934.56075644447;11442.599509017227;11514.424278786028;11532.481038353295;11543.94228028863;11585.826212606818;4217.936730949038;4282.421873047098;4449.7330160190495;4471.418715566955;4486.573775491323;9699.66051188205;9718.368306060083;9725.854112188323;9758.512074396253;9818.26363022776;4926.3349447824085;4949.133901567211;4953.653244272867;4966.577840883565;4986.800527978913;3735.458358537997;4236.491621005499;4378.321360189176;4521.276595744665;4527.637788976874;3751.437284407306;3754.849806007729;3815.771053736785;3856.903577410531;3903.121797595575;1221.5846612151734;1235.092207227687;1249.7250604866915;1251.355551890777;1253.9059570532247;823.4894365493312;848.6011574559947;858.3733874271692;864.5633954852759;871.4858233642054;5235.371755389301;5316.707581083;5406.189071639207;5419.891602168013;5532.972335138379;797.924197201265;842.2461896602506;899.7480705402497;910.6903652758094;912.4890061565544;3630.909227269339;3691.686206672463;3722.9813850930573;3730.1047748540695;3754.4368344748505;9835.114839664464;10157.746056348651;10172.796544069226;10204.38773673582;10239.84640230397;9567.856482152773;9967.55146018431;10100.848487272697;10148.797024059477;10211.438370889673;7250.891236631454;7298.379637730746;7383.9261607384315;7423.294786995335;7486.064241969754;5356.678599284055;5615.494605485526;5661.518770904355;5678.961755460974;5754.56840736938;9473.952630236805;9480.241580673668;9540.90459095428;9549.28380371461;9577.856332154885;9195.356325057182;9503.477308748084;9590.040995900354;9633.133018028411;9654.517274136124;6801.217859945971;6834.9316506836285;6917.723291068301;6940.757073502403;6967.651617419007;7734.419918506022;7822.72620458304;7835.686572537034;7844.686212551434;7850.018747656543;7097.325754053357;7199.06412166415;7297.963510182628;7333.963330183315;7336.596487193256;6271.43557079865;6496.902546461902;6517.576357536745;6782.084418603426;7165.176004759519;6010.188624535806;6204.627722336674;6206.782762603287;6269.185005949197;6359.650219237801;4362.629176519905;4381;4397.582229688174;4444.777761111996;4458.108378324413;4572.222722137178;4652.767361631973;4704.9529504704515;4736.100140973204;4756.16767065769 18:35:47 INFO - PROCESS | 3402 | |4;prototype.html;299.47591714499623;301.1612658745394;308.05273783116894;309.55424189167604;313.9591853059102;4937.5556199942;5035.370578677665;5084.745762711864;5135.717535535544;5153.6650117742365;5009.624278179142;5066.9493305066935;5077.441481437039;5096.745162741858;5126;4021.778802165887;4024.9597504025023;4025.335819589764;4031.8387264509383;4045.858394956177;3930.351492003816;4011.518617765872;4041.252368311857;4041.919161616766;4051.1695102504063;3993.640572348488;4001.97999010006;4011.59884011598;4012.2577323195155;4031.8992025199314;4021.2560676274984;4021.6179462951263;4033.858814941463;4038.3336749436453;4047.2512585171544;3581.659742324475;3583.874564390234;3587.336342776595;3587.9641203588153;3601.9639803602154;4833.685810422311;5052;5055.721935293557;5070.602696193522;5089.338386009832;4639.791209395586;4643.326717625925;4652.185867473178;4675.7895894684825;4680.3447517347595;5331.706756128411;5396.757145928404;5401.567874570025;5402.729863506848;5422.376426710939;3495.615482296945;3685.1708365617787;3686.8525258989607;3697.5025114828536;3937;5578.3584887738025;5580.525655319303;5591.692456914868;5616.438356164433;5643.407442218549;3755.605661405568;3770;3815.828287727059;3822.904427389282;3823.1589050408866;3716.9442458363146;3861;3861.7489863158803;3875.9418608720894;3920.216646181186;4420.690551661417;4429.914670905584;4454.933176002362;4478.932816007762;4491.775411229491;5324;5340.145576707708;5346.91979620306;5384.3000409947235;5411.458854114557;1230.3171739684383;1325.8210141630757;1337.9866201337861;1340.8994325425633;1353.7427888701116;891.0599317719739;895.7939673875045;897.7755561109723;915.6474757218518;916.9954150229206;4625;4632.86494808774;4651.67438279324;4667.743274119888;4685.508021657745;5521.3926468088475;5532.699815543344;5537.944620553823;5582.0231459495235;5593.860153496195;4548.522405147478;4689.718616882998;4700.153972284953;4725.220338644085;4737.763111844463;2978.717021882918;2986.4325778102525;2988.716071973159;2990.2524368907775;2995.367524699044;5214.504622060898;5216.739163041832;5217.973910130501;5229.895402092013;5244.344456942882;5481.314835645544;5719.28508936383;5745.741441635053;5752.252207213036;5843.795467158629;5197.922031169535;5221.008008478377;5226.163813789775;5230.215467679803;5257.7371131442505;5683.744231509675;5687.43125687428;5694.035557732575;5703.401142879938;5731.369549349485;5240.925610249813;5490.80782172622;5513.365962914316;5524.75138618755;5537.640053396516;5225.634205605571;5232.7033968599535;5239;5248.60635452335;5261.5264626183825;3786.413105968579;3879.301725689403;3880.049387899983;3887.591802860772;3888.2029184017774;5320.28176196224;5571.526420254162;5581.832545023493;5582.106862901916;5589.245451863946;5239.056969745482;5344.728490391491;5345.1982202669915;5345.839624811262;5364.570834333166;5341.465853414627;5377.005254028018;5420.728963551728;5445.700486473282;5446.264754258124;5130.461301563282;5293.232481290268;5295.391030031442;5305.681659100466;5377.731113444391;5407.188921661782;5420.783168673209;5423.701696406735;5464.754086066057;5484.2047903053035;5367.731613419392;5376.435474275145;5377.821982097257;5394.487523685244;5403.567714582902 18:35:47 INFO - PROCESS | 3402 | |5;yui.html;602.3043384890452;624.067019805391;682.6654939079849;713.5397668503815;748.6481353763729;12272.877271227286;13099.0830641855;13290.202587844737;13307.135036222651;13371.866281337183;12639.55761548346;13224.272665003446;13229.669258268548;13238.602841914759;13272.203667779915;630.3003665930813;756.2626439221756;769.2807225244414;771.756896577579;773.6789232468519;763.1910175214291;786.0881377601983;787.5471603827822;790.7588185603418;791.7862177212149;829.179112678447;829.7635173975387;831.9292860106898;832.8750687396879;838.1911455445494;826.4958375391006;828.4076885027205;828.4449418889328;828.6146941672151;830.6718846055835;603.7675494934438;606.3148642034516;607.4381197392438;609.9268087829489;610.0574612224125;11907.16649834512;11910.404479775976;11984.58053968107;11988.64034078979;12004.399780010965;13643.590692279247;13842.653933651638;14036.719265614733;14194.574162775134;14305.85694143066;10548.841767373495;10577.048065674126;11962.222455540448;12096.33470159141;12209.267443953391;3351.229217280015;3431.571053618298;3546.078019714867;3613.7289703272095;3630.528031355907;54687.72656136694;63932.36067639357;64082;64388.35611643871;64424.677876610316;10748.946255268673;10929.398883061349;10964.177686673373;10970.177236707119;11086.18554239644;20743.377698669065;20829.68755468669;20967.685484717742;21033.579328413653;21121.471963201042;6483.254425741005;6618.538493391954;6655.367740064686;6681.966590167115;6778.288279730557;3699.130704284491;3729.4032954727113;3748.887533374003;3769.151940813295;3786.3752480840353;2852.5863749756168;2915.367394259222;2921.415716856637;2947.042211281342;2951.749101326411;497.2119191082103;505.1589104141563;510.51246060012596;510.80334071382043;515.0060383459884;481.5160763432798;515.3403643336535;518.6162239942415;584.2171490203148;584.8654809393863;7753.1083925348175;7839.412044096715;7898.379691872529;7966.203379661987;8035.397345199133;470.45192350910804;478.2443738892541;488.7214287855888;564.4693987651594;589.711041589618;3666.944995825065;3770.71719621024;3772.9434058489146;3787.450819631138;3878.1080351518744;51842.481575184516;76366.23633763702;96931.51534242283;97853;98498.50750746201;87269.56365218133;88221.55889220512;88581.55709221541;89036.5548172255;89432.10567894368;44751.55248447474;45966.540334596895;61297.693511532154;75704.24295757082;78909;8782.51696156692;8874.911250887666;9170.67902623405;9193.402428842104;9421.62313507452;30210;30830;39786.801065994485;42787.7860610695;42903.785481072395;36645.63354366422;45480.54519454763;62119.6894015527;62730.68634656798;62869;11461.885381146081;11502.597409090642;11564.595239166589;11633.6509904703;11765.588204412805;13281.269530175932;13359.1316564423;13365.465381384636;13445.193288402726;13842.792358114435;11231;11606.187566870238;11633.6509904703;11795.52817887275;12926.676833079247;12450.315232662291;12452.128351015343;12850.100492965403;12879.227246365248;13012.544560940321;10972.396518191576;11499;11538.59614913474;11609;11893.167478276437;10038.64864729731;10386.324888882198;10476.842847357448;10647.520861561094;10686.305390149926;10232.539535720762;10658.520366583367;10847.511861966073;10886.564537418732;10898.237123401286 18:35:47 INFO - PROCESS | 3402 | __end_tp_report 18:35:47 INFO - PROCESS | 3402 | __start_cc_report 18:35:47 INFO - PROCESS | 3402 | _x_x_mozilla_cycle_collect,382 18:35:47 INFO - PROCESS | 3402 | __end_cc_report 18:35:47 INFO - PROCESS | 3402 | __startTimestamp1468632947511__endTimestamp 18:35:47 INFO - PROCESS | 3402 | 18:35:47 INFO - PROCESS | 3402 | ------- Summary: start ------- 18:35:47 INFO - PROCESS | 3402 | Number of tests: 6 18:35:47 INFO - PROCESS | 3402 | 18:35:47 INFO - PROCESS | 3402 | [#0] dojo.html Cycles:165 Average:4807.94 Median:4995.43 stddev:627.01 (12.6%) stddev-sans-first:605.11 18:35:47 INFO - PROCESS | 3402 | Values: 2625.6 2634.8 2644.4 2655.0 2674.5 4792.5 4798.6 4869.1 4871.0 4887.3 4806.3 4821.5 4873.6 4920.0 4936.9 4488.5 4498.5 4600.3 4617.4 4637.4 417.9 4392.3 4415.7 4506.2 4536.5 4460.9 4509.5 4519.7 4540.1 4572.7 4537.3 4562.8 4566.7 4575.0 4599.2 4385.8 4452.8 4472.7 4527.4 4539.0 4846.9 4904.5 4916.9 4936.3 4995.4 5002.4 5270.5 5274.8 5300.2 5326.4 5243.8 5287.9 5295.3 5311.4 5330.8 4945.8 5008.8 5014.7 5027.6 5072.5 5250.7 5280.4 5467.8 5501.6 5502.5 4996.7 5084.6 5090.5 5095.5 5149.6 5148.5 5156.1 5189.8 5195.2 5200.2 5086.8 5116.3 5122.3 5129.9 5269.7 5066.6 5073.7 5095.3 5113.4 5155.8 4399.8 4400.6 4419.1 4432.2 4461.3 3783.7 3822.8 3829.3 3831.7 3857.2 4488.6 4515.3 4517.3 4537.2 4600.4 5236.0 5255.1 5268.1 5285.9 5320.3 4401.2 4424.3 4442.8 4452.1 4452.4 4615.1 4651.8 4655.1 4665.3 4709.2 4809.0 4836.8 4845.5 4879.6 4886.8 5289.4 5342.0 5368.2 5383.9 5402.4 4972.3 4991.7 4995.5 5007.7 5066.0 4958.0 5022.9 5277.6 5290.2 5295.4 5108.0 5152.9 5167.9 5177.0 5223.7 5014.2 5026.1 5028.1 5033.4 5090.1 5001.2 5023.7 5037.9 5139.4 5167.5 5074.7 5078.3 5086.3 5135.3 5164.6 5264.3 5264.5 5267.5 5272.1 5296.0 4840.5 4890.3 4937.7 4959.8 5138.6 18:35:47 INFO - PROCESS | 3402 | 18:35:47 INFO - PROCESS | 3402 | [#1] ext.html Cycles:180 Average:48817.93 Median:37473.12 stddev:88923.12 (237.3%) stddev-sans-first:89098.77 18:35:47 INFO - PROCESS | 3402 | Values: 563.8 567.2 576.4 582.3 611.1 34869.5 39055.0 39127.6 39171.0 39174.2 39254.0 39753.2 39827.6 39882.2 40011.6 7710.7 7776.5 7844.2 7844.5 7845.9 7753.6 7769.0 7836.5 7849.4 7856.7 7797.4 7843.7 7853.6 7902.0 7908.5 7837.9 7859.6 7862.6 7868.8 7887.6 7712.8 7729.0 7775.3 7790.7 7807.4 36836.6 36959.6 37111.6 37269.0 37292.3 2910.2 2931.7 2949.9 3156.8 3363.6 29188.6 29263.4 29265.3 29403.3 29964.9 3479.3 3511.1 3526.8 3541.9 3577.6 254548.0 255166.0 256712.0 256750.7 257672.0 52270.7 52305.7 52557.5 52629.0 52699.0 32941.2 33648.3 33766.0 35683.6 35686.5 15418.2 15472.2 15526.8 15571.8 15653.5 11762.3 11850.2 11861.1 11902.1 11908.8 18132.3 18309.0 18338.7 18356.4 18380.2 6804.1 6840.7 6876.2 6967.3 7006.2 837.9 849.7 906.3 922.0 978.3 28337.9 28980.6 29235.0 29496.9 29723.3 933.0 966.2 994.6 1001.3 1004.5 14936.6 15340.6 15450.2 15456.3 15566.9 379168.0 384710.0 385679.0 388222.0 392525.0 49413.5 49441.5 49650.0 49861.8 50003.7 1171.2 1199.1 1225.7 1225.9 1228.6 27343.7 28536.4 28888.7 29213.9 29321.3 43319.6 46438.3 48005.8 48075.3 53023.9 352363.0 357823.0 358887.0 359263.0 359279.0 38649.8 39033.4 39035.2 39066.0 39109.4 42826.8 42941.6 43227.1 43282.4 44020.0 36733.3 37314.6 37361.3 38063.6 38371.6 37388.8 37557.4 37737.8 37866.0 38401.8 31120.2 35768.6 37155.0 37207.8 39274.2 32148.2 33375.8 33808.4 34425.3 34465.5 26177.6 26350.9 26413.3 26436.7 26659.0 18:35:47 INFO - PROCESS | 3402 | 18:35:47 INFO - PROCESS | 3402 | [#2] jquery.html Cycles:180 Average:17546.54 Median:394.67 stddev:26012.16 (6590.8%) stddev-sans-first:26053.18 18:35:47 INFO - PROCESS | 3402 | Values: 375.8 378.7 380.3 394.6 394.7 16250.4 17369.6 17801.2 18107.4 18115.0 17070.5 17097.1 17326.7 17659.6 17668.9 5160.3 5298.9 5323.9 5341.1 5341.5 3791.7 5965.7 6285.2 6310.1 6322.4 6141.9 6275.2 6285.6 6291.5 6314.2 6271.0 6290.1 6297.3 6304.7 6325.4 5296.8 5506.3 5527.6 5530.3 5542.9 20816.7 21187.3 21364.8 21805.8 21832.7 1917.9 1993.7 2088.7 2140.9 2491.2 13437.5 13452.7 13763.4 13813.3 13982.7 1693.6 1791.7 1801.5 1837.4 1872.2 69107.7 71750.6 71831.3 72321.6 72987.3 9322.9 9490.8 9593.6 9642.5 9847.4 13342.8 13403.7 13429.5 13446.3 13458.1 7391.7 7614.6 7667.2 7668.0 7764.7 7307.9 7400.3 7509.6 7628.0 7640.5 5464.2 6105.3 6212.2 6221.3 6227.4 1694.4 1789.7 1802.6 1820.8 1840.4 854.4 921.8 956.3 983.6 1010.6 17325.2 17431.1 17578.8 17810.8 17981.7 892.1 943.4 956.5 964.4 974.5 9258.9 10193.6 10309.5 10318.7 10471.2 131988.3 132213.0 132605.3 132680.0 132862.0 66105.0 70348.6 70668.6 71025.0 72050.0 871.5 931.5 954.4 957.4 969.5 15904.8 15934.3 16124.9 16238.9 16418.7 34590.0 35336.6 36489.5 37268.6 38394.4 54712.0 56298.7 56445.7 56597.2 57301.0 7717.8 7844.8 7886.9 7889.6 7904.1 10419.5 11458.3 11977.6 12282.8 12564.6 10007.3 10424.7 10476.7 10706.8 10899.2 9784.9 9978.0 10076.2 10250.9 10476.1 9435.3 9531.3 10036.6 10127.4 10342.2 7887.4 8082.6 8233.5 8257.8 8270.4 10146.9 10584.9 10769.8 10794.8 10861.9 18:35:47 INFO - PROCESS | 3402 | 18:35:47 INFO - PROCESS | 3402 | [#3] mootools.html Cycles:180 Average:5343.70 Median:4976.69 stddev:3052.88 (61.3%) stddev-sans-first:3046.99 18:35:47 INFO - PROCESS | 3402 | Values: 1390.9 1434.6 1517.2 1719.7 1727.6 7181.7 7894.7 7983.4 8432.5 8464.2 8079.7 8121.3 8137.0 8187.4 8223.8 2195.7 2234.7 2238.7 2242.7 2244.0 2158.4 2197.6 2231.9 2239.9 2256.0 2190.1 2212.0 2218.2 2220.4 2225.3 2173.8 2179.3 2180.7 2189.6 2199.8 2123.1 2136.5 2161.0 2162.9 2165.1 8051.7 8132.1 8135.9 8153.3 8187.9 4689.8 4823.3 4837.0 4849.1 4849.9 2918.4 2991.4 2991.8 3030.4 3096.9 887.7 901.8 925.6 929.9 934.6 11442.6 11514.4 11532.5 11543.9 11585.8 4217.9 4282.4 4449.7 4471.4 4486.6 9699.7 9718.4 9725.9 9758.5 9818.3 4926.3 4949.1 4953.7 4966.6 4986.8 3735.5 4236.5 4378.3 4521.3 4527.6 3751.4 3754.8 3815.8 3856.9 3903.1 1221.6 1235.1 1249.7 1251.4 1253.9 823.5 848.6 858.4 864.6 871.5 5235.4 5316.7 5406.2 5419.9 5533.0 797.9 842.2 899.7 910.7 912.5 3630.9 3691.7 3723.0 3730.1 3754.4 9835.1 10157.7 10172.8 10204.4 10239.8 9567.9 9967.6 10100.8 10148.8 10211.4 7250.9 7298.4 7383.9 7423.3 7486.1 5356.7 5615.5 5661.5 5679.0 5754.6 9474.0 9480.2 9540.9 9549.3 9577.9 9195.4 9503.5 9590.0 9633.1 9654.5 6801.2 6834.9 6917.7 6940.8 6967.7 7734.4 7822.7 7835.7 7844.7 7850.0 7097.3 7199.1 7298.0 7334.0 7336.6 6271.4 6496.9 6517.6 6782.1 7165.2 6010.2 6204.6 6206.8 6269.2 6359.7 4362.6 4381.0 4397.6 4444.8 4458.1 4572.2 4652.8 4705.0 4736.1 4756.2 18:35:47 INFO - PROCESS | 3402 | 18:35:47 INFO - PROCESS | 3402 | [#4] prototype.html Cycles:180 Average:4468.10 Median:5093.04 stddev:1314.41 (25.8%) stddev-sans-first:1280.31 18:35:47 INFO - PROCESS | 3402 | Values: 299.5 301.2 308.1 309.6 314.0 4937.6 5035.4 5084.7 5135.7 5153.7 5009.6 5066.9 5077.4 5096.7 5126.0 4021.8 4025.0 4025.3 4031.8 4045.9 3930.4 4011.5 4041.3 4041.9 4051.2 3993.6 4002.0 4011.6 4012.3 4031.9 4021.3 4021.6 4033.9 4038.3 4047.3 3581.7 3583.9 3587.3 3588.0 3602.0 4833.7 5052.0 5055.7 5070.6 5089.3 4639.8 4643.3 4652.2 4675.8 4680.3 5331.7 5396.8 5401.6 5402.7 5422.4 3495.6 3685.2 3686.9 3697.5 3937.0 5578.4 5580.5 5591.7 5616.4 5643.4 3755.6 3770.0 3815.8 3822.9 3823.2 3716.9 3861.0 3861.7 3875.9 3920.2 4420.7 4429.9 4454.9 4478.9 4491.8 5324.0 5340.1 5346.9 5384.3 5411.5 1230.3 1325.8 1338.0 1340.9 1353.7 891.1 895.8 897.8 915.6 917.0 4625.0 4632.9 4651.7 4667.7 4685.5 5521.4 5532.7 5537.9 5582.0 5593.9 4548.5 4689.7 4700.2 4725.2 4737.8 2978.7 2986.4 2988.7 2990.3 2995.4 5214.5 5216.7 5218.0 5229.9 5244.3 5481.3 5719.3 5745.7 5752.3 5843.8 5197.9 5221.0 5226.2 5230.2 5257.7 5683.7 5687.4 5694.0 5703.4 5731.4 5240.9 5490.8 5513.4 5524.8 5537.6 5225.6 5232.7 5239.0 5248.6 5261.5 3786.4 3879.3 3880.0 3887.6 3888.2 5320.3 5571.5 5581.8 5582.1 5589.2 5239.1 5344.7 5345.2 5345.8 5364.6 5341.5 5377.0 5420.7 5445.7 5446.3 5130.5 5293.2 5295.4 5305.7 5377.7 5407.2 5420.8 5423.7 5464.8 5484.2 5367.7 5376.4 5377.8 5394.5 5403.6 18:35:47 INFO - PROCESS | 3402 | 18:35:47 INFO - PROCESS | 3402 | [#5] yui.html Cycles:180 Average:16919.43 Median:3786.91 stddev:23561.53 (622.2%) stddev-sans-first:23595.77 18:35:47 INFO - PROCESS | 3402 | Values: 602.3 624.1 682.7 713.5 748.6 12272.9 13099.1 13290.2 13307.1 13371.9 12639.6 13224.3 13229.7 13238.6 13272.2 630.3 756.3 769.3 771.8 773.7 763.2 786.1 787.5 790.8 791.8 829.2 829.8 831.9 832.9 838.2 826.5 828.4 828.4 828.6 830.7 603.8 606.3 607.4 609.9 610.1 11907.2 11910.4 11984.6 11988.6 12004.4 13643.6 13842.7 14036.7 14194.6 14305.9 10548.8 10577.0 11962.2 12096.3 12209.3 3351.2 3431.6 3546.1 3613.7 3630.5 54687.7 63932.4 64082.0 64388.4 64424.7 10748.9 10929.4 10964.2 10970.2 11086.2 20743.4 20829.7 20967.7 21033.6 21121.5 6483.3 6618.5 6655.4 6682.0 6778.3 3699.1 3729.4 3748.9 3769.2 3786.4 2852.6 2915.4 2921.4 2947.0 2951.7 497.2 505.2 510.5 510.8 515.0 481.5 515.3 518.6 584.2 584.9 7753.1 7839.4 7898.4 7966.2 8035.4 470.5 478.2 488.7 564.5 589.7 3666.9 3770.7 3772.9 3787.5 3878.1 51842.5 76366.2 96931.5 97853.0 98498.5 87269.6 88221.6 88581.6 89036.6 89432.1 44751.6 45966.5 61297.7 75704.2 78909.0 8782.5 8874.9 9170.7 9193.4 9421.6 30210.0 30830.0 39786.8 42787.8 42903.8 36645.6 45480.5 62119.7 62730.7 62869.0 11461.9 11502.6 11564.6 11633.7 11765.6 13281.3 13359.1 13365.5 13445.2 13842.8 11231.0 11606.2 11633.7 11795.5 12926.7 12450.3 12452.1 12850.1 12879.2 13012.5 10972.4 11499.0 11538.6 11609.0 11893.2 10038.6 10386.3 10476.8 10647.5 10686.3 10232.5 10658.5 10847.5 10886.6 10898.2 18:35:47 INFO - PROCESS | 3402 | -------- Summary: end -------- 18:35:47 INFO - PROCESS | 3402 | 18:35:48 INFO - TEST-INFO | 3402: exit 0 18:35:48 INFO - TEST-OK | dromaeo_css | took 1117862ms 18:35:48 INFO - TEST-START | kraken 18:35:48 INFO - operating with platform_type : linux_ 18:35:48 INFO - Initialising browser for kraken test... 18:35:48 INFO - TEST-INFO | started process 3648 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpF16TS9/profile http://localhost:33766/getInfo.html) 18:35:53 INFO - PROCESS | 3648 | __metrics Screen width/height:1600/1200 18:35:53 INFO - PROCESS | 3648 | colorDepth:24 18:35:53 INFO - PROCESS | 3648 | Browser inner width/height: 1024/697 18:35:53 INFO - PROCESS | 3648 | __metrics 18:35:53 ERROR - PROCESS | 3648 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 18:35:54 INFO - TEST-INFO | 3648: exit 0 18:35:54 INFO - Browser initialized. 18:35:54 INFO - Running cycle 1/1 for kraken test... 18:35:54 INFO - TEST-INFO | started process 3768 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpF16TS9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:36:06 INFO - PROCESS | 3768 | RSS: Main: 169074688 18:36:06 INFO - PROCESS | 3768 | 18:36:09 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:33766/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33766/tests/kraken/driver.html?testName=audio-beat-detection) 18:36:10 INFO - PROCESS | 3768 | RSS: Main: 174059520 18:36:10 INFO - PROCESS | 3768 | 18:36:13 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:33766/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33766/tests/kraken/driver.html?testName=audio-dft) 18:36:13 INFO - PROCESS | 3768 | RSS: Main: 173948928 18:36:13 INFO - PROCESS | 3768 | 18:36:16 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:33766/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33766/tests/kraken/driver.html?testName=audio-fft) 18:36:17 INFO - PROCESS | 3768 | RSS: Main: 168767488 18:36:17 INFO - PROCESS | 3768 | 18:36:19 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:33766/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33766/tests/kraken/driver.html?testName=audio-oscillator) 18:36:20 INFO - PROCESS | 3768 | RSS: Main: 169033728 18:36:20 INFO - PROCESS | 3768 | 18:36:22 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:33766/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33766/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:36:22 INFO - PROCESS | 3768 | RSS: Main: 169492480 18:36:22 INFO - PROCESS | 3768 | 18:36:26 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:33766/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33766/tests/kraken/driver.html?testName=imaging-darkroom) 18:36:26 INFO - PROCESS | 3768 | RSS: Main: 170192896 18:36:26 INFO - PROCESS | 3768 | 18:36:30 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:33766/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33766/tests/kraken/driver.html?testName=imaging-desaturate) 18:36:31 INFO - PROCESS | 3768 | RSS: Main: 167292928 18:36:31 INFO - PROCESS | 3768 | 18:36:33 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:33766/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33766/tests/kraken/driver.html?testName=json-parse-financial) 18:36:34 INFO - PROCESS | 3768 | RSS: Main: 169152512 18:36:34 INFO - PROCESS | 3768 | 18:36:36 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:33766/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33766/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:36:36 INFO - PROCESS | 3768 | RSS: Main: 169058304 18:36:36 INFO - PROCESS | 3768 | 18:36:38 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:33766/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33766/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:36:39 INFO - PROCESS | 3768 | RSS: Main: 169193472 18:36:39 INFO - PROCESS | 3768 | 18:36:41 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:33766/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33766/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:36:42 INFO - PROCESS | 3768 | RSS: Main: 169451520 18:36:42 INFO - PROCESS | 3768 | 18:36:45 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:33766/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33766/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:36:45 INFO - PROCESS | 3768 | RSS: Main: 169742336 18:36:45 INFO - PROCESS | 3768 | 18:36:48 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:33766/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33766/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:36:49 INFO - PROCESS | 3768 | RSS: Main: 169533440 18:36:49 INFO - PROCESS | 3768 | 18:36:50 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:33766/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33766/tests/kraken/driver.html?testName=ai-astar) 18:36:51 INFO - PROCESS | 3768 | RSS: Main: 170356736 18:36:51 INFO - PROCESS | 3768 | 18:36:51 INFO - PROCESS | 3768 | __start_tp_report 18:36:51 INFO - PROCESS | 3768 | _x_x_mozilla_page_load 18:36:51 INFO - PROCESS | 3768 | _x_x_mozilla_page_load_details 18:36:51 INFO - PROCESS | 3768 | |i|pagename|runs| 18:36:51 INFO - PROCESS | 3768 | |0;ai-astar;105;116;109;114;115;117;116;117;116;116 18:36:51 INFO - PROCESS | 3768 | |1;audio-beat-detection;147;127;148;176;126;151;149;123;193;122 18:36:51 INFO - PROCESS | 3768 | |2;audio-dft;162;162;167;166;172;163;166;163;162;162 18:36:51 INFO - PROCESS | 3768 | |3;audio-fft;77;76;75;153;78;76;76;76;164;77 18:36:51 INFO - PROCESS | 3768 | |4;audio-oscillator;86;84;141;85;85;85;137;86;86;134 18:36:51 INFO - PROCESS | 3768 | |5;imaging-gaussian-blur;118;117;117;118;118;118;118;118;118;118 18:36:51 INFO - PROCESS | 3768 | |6;imaging-darkroom;152;153;148;148;148;148;148;147;148;148 18:36:51 INFO - PROCESS | 3768 | |7;imaging-desaturate;96;96;96;96;96;96;95;95;96;96 18:36:51 INFO - PROCESS | 3768 | |8;json-parse-financial;63;65;63;63;67;63;66;63;62;64 18:36:51 INFO - PROCESS | 3768 | |9;json-stringify-tinderbox;65;65;65;66;66;66;66;66;67;66 18:36:51 INFO - PROCESS | 3768 | |10;stanford-crypto-aes;79;79;80;80;80;80;80;78;87;79 18:36:51 INFO - PROCESS | 3768 | |11;stanford-crypto-ccm;142;137;129;129;128;128;132;138;183;137 18:36:51 INFO - PROCESS | 3768 | |12;stanford-crypto-pbkdf2;167;166;174;170;166;168;166;166;165;167 18:36:51 INFO - PROCESS | 3768 | |13;stanford-crypto-sha256-iterative;68;68;68;67;69;66;67;72;68;70 18:36:51 INFO - PROCESS | 3768 | __end_tp_report 18:36:51 INFO - PROCESS | 3768 | __start_cc_report 18:36:51 INFO - PROCESS | 3768 | _x_x_mozilla_cycle_collect,1020 18:36:51 INFO - PROCESS | 3768 | __end_cc_report 18:36:51 INFO - PROCESS | 3768 | __startTimestamp1468633011246__endTimestamp 18:36:51 INFO - PROCESS | 3768 | 18:36:51 INFO - PROCESS | 3768 | ------- Summary: start ------- 18:36:51 INFO - PROCESS | 3768 | Number of tests: 14 18:36:51 INFO - PROCESS | 3768 | 18:36:51 INFO - PROCESS | 3768 | [#0] ai-astar Cycles:10 Average:114.10 Median:116.00 stddev:3.96 (3.4%) stddev-sans-first:2.47 18:36:51 INFO - PROCESS | 3768 | Values: 105.0 116.0 109.0 114.0 115.0 117.0 116.0 117.0 116.0 116.0 18:36:51 INFO - PROCESS | 3768 | 18:36:51 INFO - PROCESS | 3768 | [#1] audio-beat-detection Cycles:10 Average:146.20 Median:148.50 stddev:23.60 (15.9%) stddev-sans-first:25.03 18:36:51 INFO - PROCESS | 3768 | Values: 147.0 127.0 148.0 176.0 126.0 151.0 149.0 123.0 193.0 122.0 18:36:51 INFO - PROCESS | 3768 | 18:36:51 INFO - PROCESS | 3768 | [#2] audio-dft Cycles:10 Average:164.50 Median:164.50 stddev:3.27 (2.0%) stddev-sans-first:3.35 18:36:51 INFO - PROCESS | 3768 | Values: 162.0 162.0 167.0 166.0 172.0 163.0 166.0 163.0 162.0 162.0 18:36:51 INFO - PROCESS | 3768 | 18:36:51 INFO - PROCESS | 3768 | [#3] audio-fft Cycles:10 Average:92.80 Median:76.00 stddev:34.73 (45.7%) stddev-sans-first:36.37 18:36:51 INFO - PROCESS | 3768 | Values: 77.0 76.0 75.0 153.0 78.0 76.0 76.0 76.0 164.0 77.0 18:36:51 INFO - PROCESS | 3768 | 18:36:51 INFO - PROCESS | 3768 | [#4] audio-oscillator Cycles:10 Average:100.90 Median:85.00 stddev:25.20 (29.7%) stddev-sans-first:26.15 18:36:51 INFO - PROCESS | 3768 | Values: 86.0 84.0 141.0 85.0 85.0 85.0 137.0 86.0 86.0 134.0 18:36:51 INFO - PROCESS | 3768 | 18:36:51 INFO - PROCESS | 3768 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 18:36:51 INFO - PROCESS | 3768 | Values: 118.0 117.0 117.0 118.0 118.0 118.0 118.0 118.0 118.0 118.0 18:36:51 INFO - PROCESS | 3768 | 18:36:51 INFO - PROCESS | 3768 | [#6] imaging-darkroom Cycles:10 Average:148.80 Median:148.00 stddev:1.99 (1.3%) stddev-sans-first:1.74 18:36:51 INFO - PROCESS | 3768 | Values: 152.0 153.0 148.0 148.0 148.0 148.0 148.0 147.0 148.0 148.0 18:36:51 INFO - PROCESS | 3768 | 18:36:51 INFO - PROCESS | 3768 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 18:36:51 INFO - PROCESS | 3768 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 95.0 95.0 96.0 96.0 18:36:51 INFO - PROCESS | 3768 | 18:36:51 INFO - PROCESS | 3768 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:63.50 stddev:1.60 (2.5%) stddev-sans-first:1.66 18:36:51 INFO - PROCESS | 3768 | Values: 63.0 65.0 63.0 63.0 67.0 63.0 66.0 63.0 62.0 64.0 18:36:51 INFO - PROCESS | 3768 | 18:36:51 INFO - PROCESS | 3768 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 18:36:51 INFO - PROCESS | 3768 | Values: 65.0 65.0 65.0 66.0 66.0 66.0 66.0 66.0 67.0 66.0 18:36:51 INFO - PROCESS | 3768 | 18:36:51 INFO - PROCESS | 3768 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:80.00 stddev:2.49 (3.1%) stddev-sans-first:2.60 18:36:51 INFO - PROCESS | 3768 | Values: 79.0 79.0 80.0 80.0 80.0 80.0 80.0 78.0 87.0 79.0 18:36:51 INFO - PROCESS | 3768 | 18:36:51 INFO - PROCESS | 3768 | [#11] stanford-crypto-ccm Cycles:10 Average:138.30 Median:137.00 stddev:16.47 (12.0%) stddev-sans-first:17.41 18:36:51 INFO - PROCESS | 3768 | Values: 142.0 137.0 129.0 129.0 128.0 128.0 132.0 138.0 183.0 137.0 18:36:51 INFO - PROCESS | 3768 | 18:36:51 INFO - PROCESS | 3768 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.50 Median:167.00 stddev:2.68 (1.6%) stddev-sans-first:2.83 18:36:51 INFO - PROCESS | 3768 | Values: 167.0 166.0 174.0 170.0 166.0 168.0 166.0 166.0 165.0 167.0 18:36:51 INFO - PROCESS | 3768 | 18:36:51 INFO - PROCESS | 3768 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.00 stddev:1.70 (2.5%) stddev-sans-first:1.80 18:36:51 INFO - PROCESS | 3768 | Values: 68.0 68.0 68.0 67.0 69.0 66.0 67.0 72.0 68.0 70.0 18:36:51 INFO - PROCESS | 3768 | -------- Summary: end -------- 18:36:51 INFO - PROCESS | 3768 | 18:36:52 INFO - TEST-INFO | 3768: exit 0 18:36:52 INFO - TEST-OK | kraken | took 64018ms 18:36:52 INFO - SUITE-END | took 1181s 18:36:52 INFO - Completed test suite (00:19:41) 18:36:52 INFO - javascript benchmark 18:36:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6573.704298938619, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2625.632411462396, 2634.815562910596, 2644.418227989844, 2655.0, 2674.4784766970447, 4792.472827988923, 4798.568128868405, 4869.123557759602, 4870.975645121778, 4887.340209071775, 4806.279058141281, 4821.54195351441, 4873.610111191105, 4920.0, 4936.901261974758, 4488.528704486022, 4498.482674492426, 4600.332951721998, 4617.353570500132, 4637.373954516131, 417.8723371723665, 4392.29723244281, 4415.735055896656, 4506.166359223538, 4536.5236650151755, 4460.888477788065, 4509.526499717548, 4519.683622146451, 4540.091981603692, 4572.702774319692, 4537.251353526664, 4562.794674239667, 4566.748828814414, 4574.9542504574865, 4599.195140850371, 4385.780710964471, 4452.777361131931, 4472.664550158751, 4527.411436513232, 4539.024109816405, 4846.927296090562, 4904.53406926345, 4916.852494425173, 4936.284238785356, 4995.425526064513, 5002.424721157077, 5270.525652691276, 5274.815381461669, 5300.178472336794, 5326.414094449608, 5243.8164664236565, 5287.920681189786, 5295.338082739658, 5311.442298558673, 5330.840074797762, 4945.777440015172, 5008.799648014038, 5014.674046186986, 5027.572656324181, 5072.492750724898, 5250.711210883362, 5280.419153893069, 5467.808626698046, 5501.559875209973, 5502.504774570308, 4996.650234483552, 5084.644074914794, 5090.516400941905, 5095.541401273903, 5149.562287205555, 5148.536631703165, 5156.071907056691, 5189.818356357509, 5195.220716892496, 5200.2199670049795, 5086.796528138907, 5116.309298244763, 5122.282880396748, 5129.9230511542355, 5269.657472264291, 5066.620003499752, 5073.670211436245, 5095.286659867622, 5113.411957624847, 5155.7679904404395, 4399.802008909543, 4400.559944005638, 4419.11617676466, 4432.15789000089, 4461.286194208911, 3783.7162212834146, 3822.8088595570666, 3829.291581057513, 3831.712621553339, 3857.189990102054, 4488.5960263576435, 4515.300128480091, 4517.299818528133, 4537.160625284333, 4600.378948841931, 5236.031334203185, 5255.132903071027, 5268.104422248227, 5285.920711189336, 5320.308359913264, 4401.207782599099, 4424.292113261863, 4442.800073996678, 4452.109578084396, 4452.376667266585, 4615.123126605934, 4651.837185698484, 4655.115528049728, 4665.253559430543, 4709.199436095803, 4809.038192361471, 4836.806527738921, 4845.466998630078, 4879.634027447884, 4886.755662216875, 5289.41816400188, 5341.973290133525, 5368.1679339702405, 5383.919241211307, 5402.405735369185, 4972.328735620645, 4991.725455100004, 4995.525425084611, 5007.69953802773, 5066.012127635223, 4958.0, 5022.899542009212, 5277.630565860353, 5290.232916227049, 5295.364556253275, 5108.0, 5152.948470515247, 5167.948320516897, 5177.0, 5223.686578805132, 5014.222795466709, 5026.120428924851, 5028.120078986236, 5033.421156567042, 5090.08378491875, 5001.174806157089, 5023.748812559431, 5037.924431133462, 5139.434662187231, 5167.483251674953, 5074.695518268915, 5078.289039534394, 5086.313347698014, 5135.3324067870935, 5164.612654051037, 5264.289320941624, 5264.52619264268, 5267.473252674702, 5272.103742363731, 5296.020236256305, 4840.540148685869, 4890.266460031024, 4937.728424936663, 4959.776810043629, 5138.614603904797], "value": 4768.315426681911, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.7942151114844, 567.1945836911585, 576.412059699107, 582.2983305117334, 611.0833749375936, 34869.47695784562, 39055.0, 39127.608723912716, 39171.0, 39174.21651566974, 39254.0, 39753.20493590127, 39827.60172398275, 39882.20235595293, 40011.59988400115, 7710.691572337099, 7776.53340799551, 7844.2155784421675, 7844.450888437783, 7845.921540784605, 7753.573553454557, 7769.0, 7836.490628109154, 7849.411294152933, 7856.72501462449, 7797.376209903223, 7843.686252549891, 7853.5680537570415, 7901.960490197541, 7908.485948413363, 7837.921620783804, 7859.6463159157975, 7862.606869656552, 7868.803279917991, 7887.645055972495, 7712.807179820493, 7728.961355193244, 7775.261350171724, 7790.727324543614, 7807.414443916729, 36836.63163368359, 36959.63040369589, 37111.628883711084, 37269.0, 37292.25415491702, 2910.185148158519, 2931.7361437470518, 2949.852507374644, 3156.8263745493987, 3363.613184483767, 29188.634813476172, 29263.41473170525, 29265.268368290963, 29403.264918376997, 29964.8501757492, 3479.3215323012023, 3511.0695665648623, 3526.8236588170744, 3541.8937431877084, 3577.606463289036, 254548.0, 255166.0, 256712.0, 256750.71624641944, 257672.0, 52270.73864630653, 52305.7384713074, 52557.474425255255, 52629.0, 52699.0, 32941.17647058843, 33648.327033459194, 33766.0, 35683.643163568035, 35686.46470302947, 15418.229088545528, 15472.226388680521, 15526.844731552766, 15571.84428155704, 15653.452129175424, 11762.294262344287, 11850.229735067192, 11861.11041671878, 11902.107341949388, 11908.821367679491, 18132.274709011755, 18308.993005384833, 18338.724919126224, 18356.357527486474, 18380.17289221988, 6804.081449004321, 6840.657967101625, 6876.209235937831, 6967.268436814163, 7006.2134155789945, 837.9413441059189, 849.7280870121501, 906.3474298505066, 922.0, 978.256525040974, 28337.858310708314, 28980.565291520645, 29235.0, 29496.85251573771, 29723.256918576775, 933.0, 966.246327864267, 994.627014869424, 1001.3140998416109, 1004.5178314408978, 14936.626584335261, 15340.616484587974, 15450.150241736812, 15456.304466298818, 15566.9221653891, 379168.0, 384710.0, 385679.0, 388222.0, 392525.0, 49413.50586494089, 49441.50558494441, 49650.0, 49861.750691246314, 50003.749981249865, 1171.1918776044502, 1199.0827017331749, 1225.6568160914958, 1225.914186006971, 1228.6498347970964, 27343.726562734915, 28536.42927141404, 28888.711112888603, 29213.85393073021, 29321.266968325963, 43319.56680433155, 46438.30342544932, 48005.75997119992, 48075.27887081627, 53023.93952121013, 352363.0, 357823.0, 358887.0, 359263.0, 359279.0, 38649.80675096607, 39033.414498781975, 39035.21929561449, 39066.0, 39109.41335880021, 42826.78586607047, 42941.570584295005, 43227.135457291304, 43282.35076473792, 44020.0, 36733.26533469369, 37314.62685373111, 37361.25277494489, 38063.61936380711, 38371.6162838368, 37388.813055934545, 37557.4366384499, 37737.81131094327, 37866.0, 38401.80799095987, 31120.22199445032, 35768.64231357757, 37155.0, 37207.813960931104, 39274.2145157101, 32148.19629509281, 33375.83312083424, 33808.448887456245, 34425.31149377049, 34465.48301775425, 26177.607335889596, 26350.86824565865, 26413.33966650849, 26436.735632644195, 26659.0], "value": 17843.061585359068, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.8346327615849, 378.66866491819655, 380.30973782584607, 394.6132789865931, 394.7335548504762, 16250.387294733795, 17369.56576085597, 17801.198946047425, 18107.366242181528, 18115.0, 17070.48788536346, 17097.145142742876, 17326.653466930653, 17659.64680706385, 17668.911655441738, 5160.3033590465275, 5298.947010529903, 5323.893522129555, 5341.145416733323, 5341.4925582069645, 3791.6587507124354, 5965.671888046156, 6285.151504546873, 6310.053491976194, 6322.399372059647, 6141.907871381911, 6275.152854364648, 6285.560010799246, 6291.465225455819, 6314.210723659543, 6271.0, 6290.056491526262, 6297.275813281485, 6304.716287767039, 6325.4307112359875, 5296.841094767163, 5506.311711036121, 5527.640703354309, 5530.336359636829, 5542.91685624716, 20816.687749683766, 21187.25844595447, 21364.786352136434, 21805.781942180532, 21832.672509912365, 1917.9424617261504, 1993.7308463357406, 2088.6658134698378, 2140.9143634254765, 2491.177911289288, 13437.462501499927, 13452.663683407993, 13763.38064787087, 13813.309334533233, 13982.72034559303, 1693.5935375509912, 1791.7133258678548, 1801.5406071451828, 1837.366108692499, 1872.2323847222574, 69107.65446172787, 71750.64124679395, 71831.28168718299, 72321.63839180823, 72987.27012729857, 9322.86015709765, 9490.810183796286, 9593.616255349847, 9642.517874106266, 9847.409155450552, 13342.799858002138, 13403.664908377174, 13429.462821487226, 13446.260455675032, 13458.05793594439, 7391.667374968032, 7614.619269036526, 7667.233276672399, 7668.041494813148, 7764.650590723431, 7307.8538429232185, 7400.259974002557, 7509.62451877404, 7627.961860190663, 7640.541567505968, 5464.180372944011, 6105.32841387447, 6212.192414986023, 6221.346758590283, 6227.439530442282, 1694.432365157686, 1789.6599646067205, 1802.6484835457222, 1820.8179182081685, 1840.4478656403026, 854.3634991931051, 921.801812610292, 956.3401253135314, 983.5524836199512, 1010.6210171185805, 17325.22036508335, 17431.128443578025, 17578.824211757976, 17810.821891781176, 17981.730274045898, 892.0900681305033, 943.4009404028492, 956.4739393333639, 964.3731574476506, 974.4932635029745, 9258.861117083248, 10193.592256309665, 10309.53607087683, 10318.742031449274, 10471.214658900613, 131988.3400582991, 132213.0, 132605.33697331644, 132680.0, 132862.0, 66105.0, 70348.64825675839, 70668.64665676742, 71025.0, 72050.0, 871.5250188647202, 931.4737173496952, 954.3891909178132, 957.3681370295571, 969.4813274897755, 15904.76142857835, 15934.28295726672, 16124.919375403048, 16238.918805405898, 16418.67162656764, 34590.0, 35336.64663353334, 36489.452658209615, 37268.627313726516, 38394.42408363933, 54712.0, 56298.71850640884, 56445.71777141088, 56597.15104273522, 57301.0, 7717.768466946, 7844.84310313802, 7886.921130788619, 7889.566073865993, 7904.051513818378, 10419.479026048819, 11458.312501249951, 11977.580784672844, 12282.75434491323, 12564.560240391542, 10007.349522281029, 10424.739381515523, 10476.738081548023, 10706.839397408889, 10899.182561307774, 9784.9021509784, 9977.950110249401, 10076.244281678757, 10250.948745256524, 10476.109530689671, 9435.254477921606, 9531.332806703464, 10036.598536058476, 10127.442990635585, 10342.224333175192, 7887.40844436681, 8082.595870206349, 8233.547154906299, 8257.752267431986, 8270.421070525006, 10146.949265253626, 10584.89415105839, 10769.838452423062, 10794.784104318027, 10861.945690271497], "value": 8401.639195785803, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1390.944362225511, 1434.6413396650837, 1517.2337969325488, 1719.742038694195, 1727.5940154063792, 7181.712731490734, 7894.684212631495, 7983.401244906626, 8432.451890627104, 8464.153584641534, 8079.676812927491, 8121.30968867647, 8136.982877140357, 8187.385946054055, 8223.753287401372, 2195.6596727507263, 2234.6759719840616, 2238.731352237726, 2242.686023956647, 2243.9775602244013, 2158.363282831561, 2197.571473562656, 2231.9218827341047, 2239.854409463388, 2256.0411824974403, 2190.102058156156, 2212.037763572851, 2218.170009741961, 2220.433789383705, 2225.276785044859, 2173.7500187478486, 2179.3353027326657, 2180.749213840405, 2189.6496560550236, 2199.7690242524463, 2123.108294516307, 2136.529963408048, 2160.9783902160934, 2162.8702277863376, 2165.069020321261, 8051.677932882678, 8132.064812546574, 8135.918640813576, 8153.30696890765, 8187.918120818775, 4689.8358557450665, 4823.252395878644, 4836.951630483685, 4849.127157111719, 4849.878753031167, 2918.430905973336, 2991.41667374862, 2991.8354490503016, 3030.4393687167944, 3096.90709278722, 887.7469921072463, 901.8016036471965, 925.5973651461636, 929.8558723397884, 934.56075644447, 11442.599509017227, 11514.424278786028, 11532.481038353295, 11543.94228028863, 11585.826212606818, 4217.936730949038, 4282.421873047098, 4449.7330160190495, 4471.418715566955, 4486.573775491323, 9699.66051188205, 9718.368306060083, 9725.854112188323, 9758.512074396253, 9818.26363022776, 4926.3349447824085, 4949.133901567211, 4953.653244272867, 4966.577840883565, 4986.800527978913, 3735.458358537997, 4236.491621005499, 4378.321360189176, 4521.276595744665, 4527.637788976874, 3751.437284407306, 3754.849806007729, 3815.771053736785, 3856.903577410531, 3903.121797595575, 1221.5846612151734, 1235.092207227687, 1249.7250604866915, 1251.355551890777, 1253.9059570532247, 823.4894365493312, 848.6011574559947, 858.3733874271692, 864.5633954852759, 871.4858233642054, 5235.371755389301, 5316.707581083, 5406.189071639207, 5419.891602168013, 5532.972335138379, 797.924197201265, 842.2461896602506, 899.7480705402497, 910.6903652758094, 912.4890061565544, 3630.909227269339, 3691.686206672463, 3722.9813850930573, 3730.1047748540695, 3754.4368344748505, 9835.114839664464, 10157.746056348651, 10172.796544069226, 10204.38773673582, 10239.84640230397, 9567.856482152773, 9967.55146018431, 10100.848487272697, 10148.797024059477, 10211.438370889673, 7250.891236631454, 7298.379637730746, 7383.9261607384315, 7423.294786995335, 7486.064241969754, 5356.678599284055, 5615.494605485526, 5661.518770904355, 5678.961755460974, 5754.56840736938, 9473.952630236805, 9480.241580673668, 9540.90459095428, 9549.28380371461, 9577.856332154885, 9195.356325057182, 9503.477308748084, 9590.040995900354, 9633.133018028411, 9654.517274136124, 6801.217859945971, 6834.9316506836285, 6917.723291068301, 6940.757073502403, 6967.651617419007, 7734.419918506022, 7822.72620458304, 7835.686572537034, 7844.686212551434, 7850.018747656543, 7097.325754053357, 7199.06412166415, 7297.963510182628, 7333.963330183315, 7336.596487193256, 6271.43557079865, 6496.902546461902, 6517.576357536745, 6782.084418603426, 7165.176004759519, 6010.188624535806, 6204.627722336674, 6206.782762603287, 6269.185005949197, 6359.650219237801, 4362.629176519905, 4381.0, 4397.582229688174, 4444.777761111996, 4458.108378324413, 4572.222722137178, 4652.767361631973, 4704.9529504704515, 4736.100140973204, 4756.16767065769], "value": 4276.413788683977, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.47591714499623, 301.1612658745394, 308.05273783116894, 309.55424189167604, 313.9591853059102, 4937.5556199942, 5035.370578677665, 5084.745762711864, 5135.717535535544, 5153.6650117742365, 5009.624278179142, 5066.9493305066935, 5077.441481437039, 5096.745162741858, 5126.0, 4021.778802165887, 4024.9597504025023, 4025.335819589764, 4031.8387264509383, 4045.858394956177, 3930.351492003816, 4011.518617765872, 4041.252368311857, 4041.919161616766, 4051.1695102504063, 3993.640572348488, 4001.97999010006, 4011.59884011598, 4012.2577323195155, 4031.8992025199314, 4021.2560676274984, 4021.6179462951263, 4033.858814941463, 4038.3336749436453, 4047.2512585171544, 3581.659742324475, 3583.874564390234, 3587.336342776595, 3587.9641203588153, 3601.9639803602154, 4833.685810422311, 5052.0, 5055.721935293557, 5070.602696193522, 5089.338386009832, 4639.791209395586, 4643.326717625925, 4652.185867473178, 4675.7895894684825, 4680.3447517347595, 5331.706756128411, 5396.757145928404, 5401.567874570025, 5402.729863506848, 5422.376426710939, 3495.615482296945, 3685.1708365617787, 3686.8525258989607, 3697.5025114828536, 3937.0, 5578.3584887738025, 5580.525655319303, 5591.692456914868, 5616.438356164433, 5643.407442218549, 3755.605661405568, 3770.0, 3815.828287727059, 3822.904427389282, 3823.1589050408866, 3716.9442458363146, 3861.0, 3861.7489863158803, 3875.9418608720894, 3920.216646181186, 4420.690551661417, 4429.914670905584, 4454.933176002362, 4478.932816007762, 4491.775411229491, 5324.0, 5340.145576707708, 5346.91979620306, 5384.3000409947235, 5411.458854114557, 1230.3171739684383, 1325.8210141630757, 1337.9866201337861, 1340.8994325425633, 1353.7427888701116, 891.0599317719739, 895.7939673875045, 897.7755561109723, 915.6474757218518, 916.9954150229206, 4625.0, 4632.86494808774, 4651.67438279324, 4667.743274119888, 4685.508021657745, 5521.3926468088475, 5532.699815543344, 5537.944620553823, 5582.0231459495235, 5593.860153496195, 4548.522405147478, 4689.718616882998, 4700.153972284953, 4725.220338644085, 4737.763111844463, 2978.717021882918, 2986.4325778102525, 2988.716071973159, 2990.2524368907775, 2995.367524699044, 5214.504622060898, 5216.739163041832, 5217.973910130501, 5229.895402092013, 5244.344456942882, 5481.314835645544, 5719.28508936383, 5745.741441635053, 5752.252207213036, 5843.795467158629, 5197.922031169535, 5221.008008478377, 5226.163813789775, 5230.215467679803, 5257.7371131442505, 5683.744231509675, 5687.43125687428, 5694.035557732575, 5703.401142879938, 5731.369549349485, 5240.925610249813, 5490.80782172622, 5513.365962914316, 5524.75138618755, 5537.640053396516, 5225.634205605571, 5232.7033968599535, 5239.0, 5248.60635452335, 5261.5264626183825, 3786.413105968579, 3879.301725689403, 3880.049387899983, 3887.591802860772, 3888.2029184017774, 5320.28176196224, 5571.526420254162, 5581.832545023493, 5582.106862901916, 5589.245451863946, 5239.056969745482, 5344.728490391491, 5345.1982202669915, 5345.839624811262, 5364.570834333166, 5341.465853414627, 5377.005254028018, 5420.728963551728, 5445.700486473282, 5446.264754258124, 5130.461301563282, 5293.232481290268, 5295.391030031442, 5305.681659100466, 5377.731113444391, 5407.188921661782, 5420.783168673209, 5423.701696406735, 5464.754086066057, 5484.2047903053035, 5367.731613419392, 5376.435474275145, 5377.821982097257, 5394.487523685244, 5403.567714582902], "value": 4044.861936829251, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.3043384890452, 624.067019805391, 682.6654939079849, 713.5397668503815, 748.6481353763729, 12272.877271227286, 13099.0830641855, 13290.202587844737, 13307.135036222651, 13371.866281337183, 12639.55761548346, 13224.272665003446, 13229.669258268548, 13238.602841914759, 13272.203667779915, 630.3003665930813, 756.2626439221756, 769.2807225244414, 771.756896577579, 773.6789232468519, 763.1910175214291, 786.0881377601983, 787.5471603827822, 790.7588185603418, 791.7862177212149, 829.179112678447, 829.7635173975387, 831.9292860106898, 832.8750687396879, 838.1911455445494, 826.4958375391006, 828.4076885027205, 828.4449418889328, 828.6146941672151, 830.6718846055835, 603.7675494934438, 606.3148642034516, 607.4381197392438, 609.9268087829489, 610.0574612224125, 11907.16649834512, 11910.404479775976, 11984.58053968107, 11988.64034078979, 12004.399780010965, 13643.590692279247, 13842.653933651638, 14036.719265614733, 14194.574162775134, 14305.85694143066, 10548.841767373495, 10577.048065674126, 11962.222455540448, 12096.33470159141, 12209.267443953391, 3351.229217280015, 3431.571053618298, 3546.078019714867, 3613.7289703272095, 3630.528031355907, 54687.72656136694, 63932.36067639357, 64082.0, 64388.35611643871, 64424.677876610316, 10748.946255268673, 10929.398883061349, 10964.177686673373, 10970.177236707119, 11086.18554239644, 20743.377698669065, 20829.68755468669, 20967.685484717742, 21033.579328413653, 21121.471963201042, 6483.254425741005, 6618.538493391954, 6655.367740064686, 6681.966590167115, 6778.288279730557, 3699.130704284491, 3729.4032954727113, 3748.887533374003, 3769.151940813295, 3786.3752480840353, 2852.5863749756168, 2915.367394259222, 2921.415716856637, 2947.042211281342, 2951.749101326411, 497.2119191082103, 505.1589104141563, 510.51246060012596, 510.80334071382043, 515.0060383459884, 481.5160763432798, 515.3403643336535, 518.6162239942415, 584.2171490203148, 584.8654809393863, 7753.1083925348175, 7839.412044096715, 7898.379691872529, 7966.203379661987, 8035.397345199133, 470.45192350910804, 478.2443738892541, 488.7214287855888, 564.4693987651594, 589.711041589618, 3666.944995825065, 3770.71719621024, 3772.9434058489146, 3787.450819631138, 3878.1080351518744, 51842.481575184516, 76366.23633763702, 96931.51534242283, 97853.0, 98498.50750746201, 87269.56365218133, 88221.55889220512, 88581.55709221541, 89036.5548172255, 89432.10567894368, 44751.55248447474, 45966.540334596895, 61297.693511532154, 75704.24295757082, 78909.0, 8782.51696156692, 8874.911250887666, 9170.67902623405, 9193.402428842104, 9421.62313507452, 30210.0, 30830.0, 39786.801065994485, 42787.7860610695, 42903.785481072395, 36645.63354366422, 45480.54519454763, 62119.6894015527, 62730.68634656798, 62869.0, 11461.885381146081, 11502.597409090642, 11564.595239166589, 11633.6509904703, 11765.588204412805, 13281.269530175932, 13359.1316564423, 13365.465381384636, 13445.193288402726, 13842.792358114435, 11231.0, 11606.187566870238, 11633.6509904703, 11795.52817887275, 12926.676833079247, 12450.315232662291, 12452.128351015343, 12850.100492965403, 12879.227246365248, 13012.544560940321, 10972.396518191576, 11499.0, 11538.59614913474, 11609.0, 11893.167478276437, 10038.64864729731, 10386.324888882198, 10476.842847357448, 10647.520861561094, 10686.305390149926, 10232.539535720762, 10658.520366583367, 10847.511861966073, 10886.564537418732, 10898.237123401286], "value": 6525.788668189947, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1564.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 116.0, 109.0, 114.0, 115.0, 117.0, 116.0, 117.0, 116.0, 116.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 127.0, 148.0, 176.0, 126.0, 151.0, 149.0, 123.0, 193.0, 122.0], "value": 146.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 167.0, 166.0, 172.0, 163.0, 166.0, 163.0, 162.0, 162.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 75.0, 153.0, 78.0, 76.0, 76.0, 76.0, 164.0, 77.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 141.0, 85.0, 85.0, 85.0, 137.0, 86.0, 86.0, 134.0], "value": 100.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 153.0, 148.0, 148.0, 148.0, 148.0, 148.0, 147.0, 148.0, 148.0], "value": 148.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 63.0, 63.0, 67.0, 63.0, 66.0, 63.0, 62.0, 64.0], "value": 63.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 66.0, 66.0, 66.0, 66.0, 66.0, 67.0, 66.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 80.0, 80.0, 80.0, 80.0, 80.0, 78.0, 87.0, 79.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 137.0, 129.0, 129.0, 128.0, 128.0, 132.0, 138.0, 183.0, 137.0], "value": 138.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 166.0, 174.0, 170.0, 166.0, 168.0, 166.0, 166.0, 165.0, 167.0], "value": 167.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 67.0, 69.0, 66.0, 67.0, 72.0, 68.0, 70.0], "value": 68.3, "unit": "score"}]}]} 18:36:52 INFO - Return code: 0 18:36:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:36:52 ERROR - # TBPL SUCCESS # 18:36:52 INFO - Running post-action listener: _resource_record_post_action 18:36:52 INFO - ##### 18:36:52 INFO - ##### Finished run-tests step (success) 18:36:52 INFO - ##### 18:36:52 INFO - Running post-run listener: _resource_record_post_run 18:36:52 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 7823360; Write bytes: 372273152; Read time: 1740; Write time: 173088 18:36:52 INFO - TinderboxPrint: CPU usage
13.3% 18:36:52 INFO - TinderboxPrint: I/O read bytes / time
7,823,360 / 1,740 18:36:52 INFO - TinderboxPrint: I/O write bytes / time
372,273,152 / 173,088 18:36:52 INFO - TinderboxPrint: CPU idle
8,296.5 (86.7%) 18:36:52 INFO - TinderboxPrint: CPU user
1,217.6 (12.7%) 18:36:52 INFO - TinderboxPrint: Swap in / out
0 / 0 18:36:52 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 40960; Write bytes: 70737920; Read time: 200; Write time: 21528 18:36:52 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 6037504; Write bytes: 208113664; Read time: 1340; Write time: 94384 18:36:53 INFO - Running post-run listener: _upload_blobber_files 18:36:53 INFO - Blob upload gear active. 18:36:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:36:53 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 18:36:53 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'] 18:36:53 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 18:36:53 INFO - (blobuploader) - INFO - Open directory for files ... 18:36:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:36:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:36:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:36:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:36:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:36:54 INFO - (blobuploader) - INFO - Done attempting. 18:36:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:36:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:36:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:36:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:36:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:36:59 INFO - (blobuploader) - INFO - Done attempting. 18:36:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:36:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:36:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:37:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:37:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:37:00 INFO - (blobuploader) - INFO - Done attempting. 18:37:00 INFO - (blobuploader) - INFO - Iteration through files over. 18:37:00 INFO - Return code: 0 18:37:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:37:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:37:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f77a39c5df5787c793493e024a6f85765623d6c8808e4119ab5fb8d0c5654c63ef24879ebf07cc71cab13b4cf6eb366523a74315650c67a2323ee3d555e983dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7bad1fab024932d2ae50b0601d5ef97c48889a1272c3dc2d7dd33be8041e4758ba50c065f40da5fd8f2c96cdae7105198233cd8d30a436811535b2b5f6468065", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2568dd895836c18b2de0841f2c70b3f0ac26039a207bb1ce5fb11c5d7183646362f6c9111fedc4656bec76cd8d8fddfde95ec21c71da804ebaa191960f4d1cbb"} 18:37:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:37:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:37:00 INFO - Contents: 18:37:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f77a39c5df5787c793493e024a6f85765623d6c8808e4119ab5fb8d0c5654c63ef24879ebf07cc71cab13b4cf6eb366523a74315650c67a2323ee3d555e983dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7bad1fab024932d2ae50b0601d5ef97c48889a1272c3dc2d7dd33be8041e4758ba50c065f40da5fd8f2c96cdae7105198233cd8d30a436811535b2b5f6468065", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2568dd895836c18b2de0841f2c70b3f0ac26039a207bb1ce5fb11c5d7183646362f6c9111fedc4656bec76cd8d8fddfde95ec21c71da804ebaa191960f4d1cbb"} 18:37:00 INFO - Running post-run listener: copy_logs_to_upload_dir 18:37:00 INFO - Copying logs to upload dir... 18:37:00 INFO - mkdir: /builds/slave/test/build/upload/logs 18:37:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.129610 ========= master_lag: 9.74 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-07-15 18:37:10.113100) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 18:37:10.116703) ========= 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=a0d2d2de893abaa8702a9954000001a7-1468631021.344905-55548007 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f77a39c5df5787c793493e024a6f85765623d6c8808e4119ab5fb8d0c5654c63ef24879ebf07cc71cab13b4cf6eb366523a74315650c67a2323ee3d555e983dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7bad1fab024932d2ae50b0601d5ef97c48889a1272c3dc2d7dd33be8041e4758ba50c065f40da5fd8f2c96cdae7105198233cd8d30a436811535b2b5f6468065", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2568dd895836c18b2de0841f2c70b3f0ac26039a207bb1ce5fb11c5d7183646362f6c9111fedc4656bec76cd8d8fddfde95ec21c71da804ebaa191960f4d1cbb"} build_url:https://queue.taskcluster.net/v1/task/ZMP9nlweSZ2bNNrwCzRWcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011086 build_url: 'https://queue.taskcluster.net/v1/task/ZMP9nlweSZ2bNNrwCzRWcw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f77a39c5df5787c793493e024a6f85765623d6c8808e4119ab5fb8d0c5654c63ef24879ebf07cc71cab13b4cf6eb366523a74315650c67a2323ee3d555e983dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7bad1fab024932d2ae50b0601d5ef97c48889a1272c3dc2d7dd33be8041e4758ba50c065f40da5fd8f2c96cdae7105198233cd8d30a436811535b2b5f6468065", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2568dd895836c18b2de0841f2c70b3f0ac26039a207bb1ce5fb11c5d7183646362f6c9111fedc4656bec76cd8d8fddfde95ec21c71da804ebaa191960f4d1cbb"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 18:37:10.155562) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 18:37:10.155875) ========= 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=a0d2d2de893abaa8702a9954000001a7-1468631021.344905-55548007 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004473 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 18:37:10.204989) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 18:37:10.205304) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 18:37:10.205578) ========= ========= Total master_lag: 9.87 =========