builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-061 starttime: 1469201741.76 results: success (0) buildid: 20160722080026 builduid: c29f9f9830d3452da61197b155ab2c91 revision: ff29f08b72c466b65dea5efa6f82f99add8f17ef ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-22 08:35:41.757518) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-22 08:35:41.758036) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-22 08:35:41.758362) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-22 08:35:41.775450) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 08:35:41.776136) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1469201741.255-1261785442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-22 08:35:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-07-22 08:35:42 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.153644 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 08:35:41.989480) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 08:35:41.989846) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1469201741.255-1261785442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020154 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 08:35:42.025192) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-22 08:35:42.026028) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ff29f08b72c466b65dea5efa6f82f99add8f17ef --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 ff29f08b72c466b65dea5efa6f82f99add8f17ef --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=516f8d7ca085b4d087ab0a71000001a4-1469201741.255-1261785442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-22 08:35:42,334 truncating revision to first 12 chars 2016-07-22 08:35:42,335 Setting DEBUG logging. 2016-07-22 08:35:42,335 attempt 1/10 2016-07-22 08:35:42,335 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ff29f08b72c4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-22 08:35:43,710 unpacking tar archive at: fx-team-ff29f08b72c4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.704662 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-22 08:35:43.750714) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-22 08:35:43.751442) ========= script_repo_revision: ff29f08b72c466b65dea5efa6f82f99add8f17ef ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-22 08:35:43.752158) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-22 08:35:43.752757) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-22 08:35:43.764864) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-07-22 08:35:43.765180) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=516f8d7ca085b4d087ab0a71000001a4-1469201741.255-1261785442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:35:44 INFO - MultiFileLogger online at 20160722 08:35:44 in /builds/slave/test 08:35:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 08:35:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:35:44 INFO - {'append_to_log': False, 08:35:44 INFO - 'base_work_dir': '/builds/slave/test', 08:35:44 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:35:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:35:44 INFO - 'branch': 'Fx-Team-Non-PGO', 08:35:44 INFO - 'buildbot_json_path': 'buildprops.json', 08:35:44 INFO - 'config_files': ('talos/linux_config.py',), 08:35:44 INFO - 'default_actions': ('clobber', 08:35:44 INFO - 'read-buildbot-config', 08:35:44 INFO - 'download-and-extract', 08:35:44 INFO - 'populate-webroot', 08:35:44 INFO - 'create-virtualenv', 08:35:44 INFO - 'install', 08:35:44 INFO - 'run-tests'), 08:35:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:35:44 INFO - 'download_minidump_stackwalk': True, 08:35:44 INFO - 'download_symbols': 'ondemand', 08:35:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:35:44 INFO - 'tooltool.py': '/tools/tooltool.py', 08:35:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:35:44 INFO - '/tools/misc-python/virtualenv.py')}, 08:35:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:35:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:35:44 INFO - 'installer_path': 'installer.exe', 08:35:44 INFO - 'log_level': 'info', 08:35:44 INFO - 'log_name': 'talos', 08:35:44 INFO - 'log_to_console': True, 08:35:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:35:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:35:44 INFO - 'opt_config_files': (), 08:35:44 INFO - 'pip_index': False, 08:35:44 INFO - 'sps_profile': False, 08:35:44 INFO - 'sps_profile_interval': 0, 08:35:44 INFO - 'suite': 'dromaeojs', 08:35:44 INFO - 'system_bits': '32', 08:35:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:35:44 INFO - 'title': 'talos-linux64-ix-061', 08:35:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:35:44 INFO - 'use_talos_json': True, 08:35:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:35:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:35:44 INFO - 'work_dir': 'build'} 08:35:44 INFO - [mozharness: 2016-07-22 15:35:44.164121Z] Running clobber step. 08:35:44 INFO - Running pre-action listener: _resource_record_pre_action 08:35:44 INFO - Running main action method: clobber 08:35:44 INFO - rmtree: /builds/slave/test/build 08:35:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:35:44 INFO - Running post-action listener: _resource_record_post_action 08:35:44 INFO - [mozharness: 2016-07-22 15:35:44.627643Z] Finished clobber step (success) 08:35:44 INFO - [mozharness: 2016-07-22 15:35:44.627764Z] Running read-buildbot-config step. 08:35:44 INFO - Running pre-action listener: _resource_record_pre_action 08:35:44 INFO - Running main action method: read_buildbot_config 08:35:44 INFO - Using buildbot properties: 08:35:44 INFO - { 08:35:44 INFO - "project": "", 08:35:44 INFO - "product": "firefox", 08:35:44 INFO - "script_repo_revision": "production", 08:35:44 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:35:44 INFO - "repository": "", 08:35:44 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 08:35:44 INFO - "buildid": "20160722080026", 08:35:44 INFO - "pgo_build": "False", 08:35:44 INFO - "basedir": "/builds/slave/test", 08:35:44 INFO - "buildnumber": 1819, 08:35:44 INFO - "slavename": "talos-linux64-ix-061", 08:35:44 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:35:44 INFO - "platform": "ubuntu64_hw", 08:35:44 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:35:44 INFO - "branch": "fx-team", 08:35:44 INFO - "repo_path": "integration/fx-team", 08:35:44 INFO - "revision": "ff29f08b72c466b65dea5efa6f82f99add8f17ef", 08:35:44 INFO - "stage_platform": "linux64", 08:35:44 INFO - "builduid": "c29f9f9830d3452da61197b155ab2c91", 08:35:44 INFO - "slavebuilddir": "test" 08:35:44 INFO - } 08:35:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/TjzSkRXaSjOvNfAcPzLQ7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:35:44 INFO - Running post-action listener: _resource_record_post_action 08:35:44 INFO - [mozharness: 2016-07-22 15:35:44.630198Z] Finished read-buildbot-config step (success) 08:35:44 INFO - [mozharness: 2016-07-22 15:35:44.630288Z] Running download-and-extract step. 08:35:44 INFO - Running pre-action listener: _resource_record_pre_action 08:35:44 INFO - Running main action method: download_and_extract 08:35:44 INFO - mkdir: /builds/slave/test/build/tests 08:35:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:35:44 INFO - https://queue.taskcluster.net/v1/task/TjzSkRXaSjOvNfAcPzLQ7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:35:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TjzSkRXaSjOvNfAcPzLQ7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:35:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TjzSkRXaSjOvNfAcPzLQ7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:35:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TjzSkRXaSjOvNfAcPzLQ7A/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 08:35:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TjzSkRXaSjOvNfAcPzLQ7A/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 08:35:45 INFO - Downloaded 1361 bytes. 08:35:45 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:35:45 INFO - Using the following test package requirements: 08:35:45 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:35:45 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:35:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:35:45 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:35:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:35:45 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:35:45 INFO - u'jsshell-linux-x86_64.zip'], 08:35:45 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:35:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:35:45 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:35:45 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:35:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:35:45 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:35:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:35:45 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:35:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:35:45 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:35:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:35:45 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:35: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')]} 08:35:45 INFO - https://queue.taskcluster.net/v1/task/TjzSkRXaSjOvNfAcPzLQ7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:35:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TjzSkRXaSjOvNfAcPzLQ7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:35:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TjzSkRXaSjOvNfAcPzLQ7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:35:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TjzSkRXaSjOvNfAcPzLQ7A/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 08:35:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TjzSkRXaSjOvNfAcPzLQ7A/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 08:35:46 INFO - Downloaded 22737593 bytes. 08:35:46 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'] 08:35:46 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 08:35:47 INFO - Return code: 0 08:35:47 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 08:35:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:35:47 INFO - https://queue.taskcluster.net/v1/task/TjzSkRXaSjOvNfAcPzLQ7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:35:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TjzSkRXaSjOvNfAcPzLQ7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:35:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TjzSkRXaSjOvNfAcPzLQ7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:35:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TjzSkRXaSjOvNfAcPzLQ7A/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 08:35:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TjzSkRXaSjOvNfAcPzLQ7A/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 08:35:48 INFO - Downloaded 22737593 bytes. 08:35:48 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'] 08:35:48 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 08:35:50 INFO - Return code: 0 08:35:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:35:50 INFO - https://queue.taskcluster.net/v1/task/TjzSkRXaSjOvNfAcPzLQ7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:35:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TjzSkRXaSjOvNfAcPzLQ7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:35:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TjzSkRXaSjOvNfAcPzLQ7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:35:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TjzSkRXaSjOvNfAcPzLQ7A/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 08:35:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TjzSkRXaSjOvNfAcPzLQ7A/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 08:35:51 INFO - Downloaded 14403289 bytes. 08:35:51 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'] 08:35:51 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 08:35:51 INFO - Return code: 0 08:35:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:35:51 INFO - https://queue.taskcluster.net/v1/task/TjzSkRXaSjOvNfAcPzLQ7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:35:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TjzSkRXaSjOvNfAcPzLQ7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:35:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TjzSkRXaSjOvNfAcPzLQ7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:35:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TjzSkRXaSjOvNfAcPzLQ7A/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 08:35:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TjzSkRXaSjOvNfAcPzLQ7A/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 08:35:52 INFO - Downloaded 57157412 bytes. 08:35:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TjzSkRXaSjOvNfAcPzLQ7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:35:52 INFO - mkdir: /builds/slave/test/properties 08:35:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:35:52 INFO - Writing to file /builds/slave/test/properties/build_url 08:35:52 INFO - Contents: 08:35:52 INFO - build_url:https://queue.taskcluster.net/v1/task/TjzSkRXaSjOvNfAcPzLQ7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:35:53 INFO - Running post-action listener: _resource_record_post_action 08:35:53 INFO - Running post-action listener: set_extra_try_arguments 08:35:53 INFO - [mozharness: 2016-07-22 15:35:53.285476Z] Finished download-and-extract step (success) 08:35:53 INFO - [mozharness: 2016-07-22 15:35:53.285710Z] Running populate-webroot step. 08:35:53 INFO - Running pre-action listener: _resource_record_pre_action 08:35:53 INFO - Running main action method: populate_webroot 08:35:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:35:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:35:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:35:53 INFO - '--tppagecycles', 08:35:53 INFO - '7'], 08:35:53 INFO - 'tests': ['tsvgm']}}, 08:35:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:35:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:35:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:35:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:35:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:35:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:35:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:35:53 INFO - 'talos_options': ['--disable-e10s'], 08:35:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:35:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:35:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:35:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:35:53 INFO - 'talos_options': ['--disable-e10s'], 08:35:53 INFO - 'tests': ['damp', 'tps']}, 08:35:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:35:53 INFO - 'tests': ['damp', 'tps']}, 08:35:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:35:53 INFO - 'tests': ['dromaeo_dom']}, 08:35:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:35:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:35:53 INFO - 'tests': ['basic_compositor_video']}, 08:35:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:35:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:35:53 INFO - 'tests': ['a11yr', 08:35:53 INFO - 'ts_paint', 08:35:53 INFO - 'tpaint', 08:35:53 INFO - 'sessionrestore', 08:35:53 INFO - 'sessionrestore_no_auto_restore', 08:35:53 INFO - 'tabpaint']}, 08:35:53 INFO - 'other-e10s': {'tests': ['a11yr', 08:35:53 INFO - 'ts_paint', 08:35:53 INFO - 'tpaint', 08:35:53 INFO - 'sessionrestore', 08:35:53 INFO - 'sessionrestore_no_auto_restore', 08:35:53 INFO - 'tabpaint']}, 08:35:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:35:53 INFO - 'ts_paint', 08:35:53 INFO - 'tpaint', 08:35:53 INFO - 'sessionrestore', 08:35:53 INFO - 'sessionrestore_no_auto_restore', 08:35:53 INFO - 'tabpaint']}, 08:35:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:35:53 INFO - 'ts_paint', 08:35:53 INFO - 'tpaint', 08:35:53 INFO - 'sessionrestore', 08:35:53 INFO - 'sessionrestore_no_auto_restore', 08:35:53 INFO - 'tabpaint']}, 08:35:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:35:53 INFO - 'tests': ['a11yr', 08:35:53 INFO - 'ts_paint', 08:35:53 INFO - 'tpaint', 08:35:53 INFO - 'sessionrestore', 08:35:53 INFO - 'sessionrestore_no_auto_restore', 08:35:53 INFO - 'tabpaint']}, 08:35:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:35:53 INFO - 'tests': ['a11yr', 08:35:53 INFO - 'ts_paint', 08:35:53 INFO - 'tpaint', 08:35:53 INFO - 'sessionrestore', 08:35:53 INFO - 'sessionrestore_no_auto_restore', 08:35:53 INFO - 'tabpaint']}, 08:35:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:35:53 INFO - 'tests': ['tsvgx', 08:35:53 INFO - 'tsvgr_opacity', 08:35:53 INFO - 'tart', 08:35:53 INFO - 'tscrollx', 08:35:53 INFO - 'cart']}, 08:35:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:35:53 INFO - 'tsvgr_opacity', 08:35:53 INFO - 'tart', 08:35:53 INFO - 'tscrollx', 08:35:53 INFO - 'cart']}, 08:35:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:35:53 INFO - 'talos_options': ['--disable-e10s'], 08:35:53 INFO - 'tests': ['tp5o']}, 08:35:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:35:53 INFO - 'tests': ['tp5o']}, 08:35:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:35:53 INFO - 'talos_options': ['--disable-e10s', 08:35:53 INFO - '--xperf_path', 08:35:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:35:53 INFO - 'tests': ['tp5n']}, 08:35:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:35:53 INFO - 'talos_options': ['--xperf_path', 08:35:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:35:53 INFO - 'tests': ['tp5n']}}, 08:35:53 INFO - 'talos.zip': {'path': '', 08:35:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:35:53 INFO - Running post-action listener: _resource_record_post_action 08:35:53 INFO - [mozharness: 2016-07-22 15:35:53.302964Z] Finished populate-webroot step (success) 08:35:53 INFO - [mozharness: 2016-07-22 15:35:53.303053Z] Running create-virtualenv step. 08:35:53 INFO - Running pre-action listener: _resource_record_pre_action 08:35:53 INFO - Running main action method: create_virtualenv 08:35:53 INFO - Creating virtualenv /builds/slave/test/build/venv 08:35:53 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 08:35:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:35:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:35:53 INFO - Using real prefix '/usr' 08:35:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:35:53 INFO - Installing distribute.............................................................................................................................................................................................done. 08:35:55 INFO - Installing pip.................done. 08:35:55 INFO - Return code: 0 08:35:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:35:55 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')]} 08:35:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:55 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')]} 08:35:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:55 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 0x242f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ee3b0>, '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 0x26ef2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ef740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1469201741.255-1261785442', '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 08:35:55 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 08:35:55 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 08:35:55 INFO - Using env: {'DISPLAY': ':0', 08:35:55 INFO - 'HOME': '/home/cltbld', 08:35:55 INFO - 'LANG': 'en_US.UTF-8', 08:35:55 INFO - 'LANGUAGE': 'en_US:en', 08:35:55 INFO - 'LOGNAME': 'cltbld', 08:35:55 INFO - 'MAIL': '/var/mail/cltbld', 08:35:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:55 INFO - 'MOZ_NO_REMOTE': '1', 08:35:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:35:55 INFO - 'NO_EM_RESTART': '1', 08:35:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:35:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:55 INFO - 'PWD': '/builds/slave/test', 08:35:55 INFO - 'SHELL': '/bin/bash', 08:35:55 INFO - 'SHLVL': '1', 08:35:55 INFO - 'TERM': 'linux', 08:35:55 INFO - 'TMOUT': '86400', 08:35:55 INFO - 'USER': 'cltbld', 08:35:55 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1469201741.255-1261785442', 08:35:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:55 INFO - '_': '/tools/buildbot/bin/python'} 08:35:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:56 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 08:35:56 INFO - Cleaning up... 08:35:56 INFO - Return code: 0 08:35:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:35:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:35:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x242f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ee3b0>, '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 0x26ef2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ef740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1469201741.255-1261785442', '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 08:35:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:35:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:35:56 INFO - Using env: {'DISPLAY': ':0', 08:35:56 INFO - 'HOME': '/home/cltbld', 08:35:56 INFO - 'LANG': 'en_US.UTF-8', 08:35:56 INFO - 'LANGUAGE': 'en_US:en', 08:35:56 INFO - 'LOGNAME': 'cltbld', 08:35:56 INFO - 'MAIL': '/var/mail/cltbld', 08:35:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:56 INFO - 'MOZ_NO_REMOTE': '1', 08:35:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:35:56 INFO - 'NO_EM_RESTART': '1', 08:35:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:35:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:56 INFO - 'PWD': '/builds/slave/test', 08:35:56 INFO - 'SHELL': '/bin/bash', 08:35:56 INFO - 'SHLVL': '1', 08:35:56 INFO - 'TERM': 'linux', 08:35:56 INFO - 'TMOUT': '86400', 08:35:56 INFO - 'USER': 'cltbld', 08:35:56 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1469201741.255-1261785442', 08:35:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:56 INFO - '_': '/tools/buildbot/bin/python'} 08:35:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:56 INFO - Downloading/unpacking psutil>=3.1.1 08:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:35:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:35:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:35:58 INFO - Installing collected packages: psutil 08:35:58 INFO - Running setup.py install for psutil 08:35:58 INFO - building 'psutil._psutil_linux' extension 08:35:58 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 08:35:58 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 08:35:58 INFO - building 'psutil._psutil_posix' extension 08:35:58 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 08:35:58 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 08:35:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:35:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:35:58 INFO - Successfully installed psutil 08:35:58 INFO - Cleaning up... 08:35:58 INFO - Return code: 0 08:35:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:35:58 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')]} 08:35:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:58 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')]} 08:35:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:58 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 0x242f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ee3b0>, '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 0x26ef2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ef740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1469201741.255-1261785442', '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 08:35:58 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 08:35:58 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 08:35:58 INFO - Using env: {'DISPLAY': ':0', 08:35:58 INFO - 'HOME': '/home/cltbld', 08:35:58 INFO - 'LANG': 'en_US.UTF-8', 08:35:58 INFO - 'LANGUAGE': 'en_US:en', 08:35:58 INFO - 'LOGNAME': 'cltbld', 08:35:58 INFO - 'MAIL': '/var/mail/cltbld', 08:35:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:58 INFO - 'MOZ_NO_REMOTE': '1', 08:35:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:35:58 INFO - 'NO_EM_RESTART': '1', 08:35:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:35:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:58 INFO - 'PWD': '/builds/slave/test', 08:35:58 INFO - 'SHELL': '/bin/bash', 08:35:58 INFO - 'SHLVL': '1', 08:35:58 INFO - 'TERM': 'linux', 08:35:58 INFO - 'TMOUT': '86400', 08:35:58 INFO - 'USER': 'cltbld', 08:35:58 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1469201741.255-1261785442', 08:35:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:58 INFO - '_': '/tools/buildbot/bin/python'} 08:35:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:35:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:36:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:36:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:36:01 INFO - Installing collected packages: mozsystemmonitor 08:36:01 INFO - Running setup.py install for mozsystemmonitor 08:36:01 INFO - Successfully installed mozsystemmonitor 08:36:01 INFO - Cleaning up... 08:36:01 INFO - Return code: 0 08:36:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:36:01 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')]} 08:36:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:01 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')]} 08:36:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:01 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 0x242f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ee3b0>, '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 0x26ef2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ef740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1469201741.255-1261785442', '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 08:36:01 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 08:36:01 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 08:36:01 INFO - Using env: {'DISPLAY': ':0', 08:36:01 INFO - 'HOME': '/home/cltbld', 08:36:01 INFO - 'LANG': 'en_US.UTF-8', 08:36:01 INFO - 'LANGUAGE': 'en_US:en', 08:36:01 INFO - 'LOGNAME': 'cltbld', 08:36:01 INFO - 'MAIL': '/var/mail/cltbld', 08:36:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:01 INFO - 'MOZ_NO_REMOTE': '1', 08:36:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:01 INFO - 'NO_EM_RESTART': '1', 08:36:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:01 INFO - 'PWD': '/builds/slave/test', 08:36:01 INFO - 'SHELL': '/bin/bash', 08:36:01 INFO - 'SHLVL': '1', 08:36:01 INFO - 'TERM': 'linux', 08:36:01 INFO - 'TMOUT': '86400', 08:36:01 INFO - 'USER': 'cltbld', 08:36:01 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1469201741.255-1261785442', 08:36:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:01 INFO - '_': '/tools/buildbot/bin/python'} 08:36:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:01 INFO - Downloading/unpacking jsonschema==2.5.1 08:36:01 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 08:36:01 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 08:36:01 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 08:36:01 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 08:36:01 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 08:36:01 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 08:36:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:36:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:36:03 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 08:36:03 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 08:36:03 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 08:36:03 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 08:36:03 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 08:36:03 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 08:36:03 INFO - Downloading functools32-3.2.3-2.tar.gz 08:36:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:36:03 INFO - warning: no files found matching '*.txt' 08:36:03 INFO - no previously-included directories found matching 'build' 08:36:03 INFO - no previously-included directories found matching 'dist' 08:36:03 INFO - no previously-included directories found matching '.git*' 08:36:03 INFO - Installing collected packages: jsonschema, functools32 08:36:03 INFO - Running setup.py install for functools32 08:36:03 INFO - warning: no files found matching '*.txt' 08:36:03 INFO - no previously-included directories found matching 'build' 08:36:03 INFO - no previously-included directories found matching 'dist' 08:36:03 INFO - no previously-included directories found matching '.git*' 08:36:03 INFO - Successfully installed jsonschema functools32 08:36:03 INFO - Cleaning up... 08:36:03 INFO - Return code: 0 08:36:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:36:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x242f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ee3b0>, '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 0x26ef2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ef740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1469201741.255-1261785442', '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 08:36:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:36:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:36:03 INFO - Using env: {'DISPLAY': ':0', 08:36:03 INFO - 'HOME': '/home/cltbld', 08:36:03 INFO - 'LANG': 'en_US.UTF-8', 08:36:03 INFO - 'LANGUAGE': 'en_US:en', 08:36:03 INFO - 'LOGNAME': 'cltbld', 08:36:03 INFO - 'MAIL': '/var/mail/cltbld', 08:36:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:03 INFO - 'MOZ_NO_REMOTE': '1', 08:36:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:03 INFO - 'NO_EM_RESTART': '1', 08:36:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:03 INFO - 'PWD': '/builds/slave/test', 08:36:03 INFO - 'SHELL': '/bin/bash', 08:36:03 INFO - 'SHLVL': '1', 08:36:03 INFO - 'TERM': 'linux', 08:36:03 INFO - 'TMOUT': '86400', 08:36:03 INFO - 'USER': 'cltbld', 08:36:03 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1469201741.255-1261785442', 08:36:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:03 INFO - '_': '/tools/buildbot/bin/python'} 08:36:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:03 INFO - Downloading/unpacking blobuploader==1.2.4 08:36:03 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 08:36:03 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 08:36:03 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 08:36:03 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 08:36:03 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 08:36:03 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 08:36:05 INFO - Downloading blobuploader-1.2.4.tar.gz 08:36:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:36:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:36:05 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 08:36:05 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 08:36:05 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 08:36:05 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 08:36:05 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 08:36:05 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 08:36:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:36:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:36:06 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 08:36:06 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 08:36:06 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 08:36:06 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 08:36:06 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 08:36:06 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 08:36:06 INFO - Downloading docopt-0.6.1.tar.gz 08:36:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:36:06 INFO - Installing collected packages: blobuploader, requests, docopt 08:36:06 INFO - Running setup.py install for blobuploader 08:36:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:36:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:36:06 INFO - Running setup.py install for requests 08:36:07 INFO - Running setup.py install for docopt 08:36:07 INFO - Successfully installed blobuploader requests docopt 08:36:07 INFO - Cleaning up... 08:36:07 INFO - Return code: 0 08:36:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:36:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:07 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 0x242f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ee3b0>, '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 0x26ef2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ef740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1469201741.255-1261785442', '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 08:36:07 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 08:36:07 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 08:36:07 INFO - Using env: {'DISPLAY': ':0', 08:36:07 INFO - 'HOME': '/home/cltbld', 08:36:07 INFO - 'LANG': 'en_US.UTF-8', 08:36:07 INFO - 'LANGUAGE': 'en_US:en', 08:36:07 INFO - 'LOGNAME': 'cltbld', 08:36:07 INFO - 'MAIL': '/var/mail/cltbld', 08:36:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:07 INFO - 'MOZ_NO_REMOTE': '1', 08:36:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:07 INFO - 'NO_EM_RESTART': '1', 08:36:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:07 INFO - 'PWD': '/builds/slave/test', 08:36:07 INFO - 'SHELL': '/bin/bash', 08:36:07 INFO - 'SHLVL': '1', 08:36:07 INFO - 'TERM': 'linux', 08:36:07 INFO - 'TMOUT': '86400', 08:36:07 INFO - 'USER': 'cltbld', 08:36:07 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1469201741.255-1261785442', 08:36:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:07 INFO - '_': '/tools/buildbot/bin/python'} 08:36:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:36:07 INFO - Running setup.py (path:/tmp/pip-lgW2y9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:36:07 INFO - Running setup.py (path:/tmp/pip-38Xjvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:36:07 INFO - Running setup.py (path:/tmp/pip-K3sRLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:36:07 INFO - Running setup.py (path:/tmp/pip-XRK9PF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:36:07 INFO - Running setup.py (path:/tmp/pip-AHw__c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:36:07 INFO - Running setup.py (path:/tmp/pip-Z2FVTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:36:07 INFO - Running setup.py (path:/tmp/pip-Rj0pVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:36:07 INFO - Running setup.py (path:/tmp/pip-sMDAqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:36:08 INFO - Running setup.py (path:/tmp/pip-YE7F1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:36:08 INFO - Running setup.py (path:/tmp/pip-hnAYX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:36:08 INFO - Running setup.py (path:/tmp/pip-RQzkk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:36:08 INFO - Running setup.py (path:/tmp/pip-rD7ocR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:36:08 INFO - Running setup.py (path:/tmp/pip-EoYb3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:36:08 INFO - Running setup.py (path:/tmp/pip-NsaM3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:36:08 INFO - Running setup.py (path:/tmp/pip-NXQVBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:36:08 INFO - Running setup.py (path:/tmp/pip-6KNwV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:36:08 INFO - Running setup.py (path:/tmp/pip-Yy6vON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:36:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:36:08 INFO - Running setup.py install for manifestparser 08:36:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:36:08 INFO - Running setup.py install for mozcrash 08:36:08 INFO - Running setup.py install for mozdebug 08:36:08 INFO - Running setup.py install for mozdevice 08:36:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:36:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:36:09 INFO - Running setup.py install for mozfile 08:36:09 INFO - Running setup.py install for mozhttpd 08:36:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:36:09 INFO - Running setup.py install for mozinfo 08:36:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:36:09 INFO - Running setup.py install for mozInstall 08:36:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:36:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:36:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:36:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:36:09 INFO - Running setup.py install for mozleak 08:36:09 INFO - Running setup.py install for mozlog 08:36:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:36:09 INFO - Running setup.py install for moznetwork 08:36:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:36:09 INFO - Running setup.py install for mozprocess 08:36:09 INFO - Running setup.py install for mozprofile 08:36:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:36:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:36:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:36:10 INFO - Running setup.py install for mozrunner 08:36:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:36:10 INFO - Running setup.py install for mozscreenshot 08:36:10 INFO - Running setup.py install for moztest 08:36:10 INFO - Running setup.py install for mozversion 08:36:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:36:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:36:10 INFO - Cleaning up... 08:36:10 INFO - Return code: 0 08:36:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:36:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:10 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 0x242f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ee3b0>, '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 0x26ef2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ef740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1469201741.255-1261785442', '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 08:36:10 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 08:36:10 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 08:36:10 INFO - Using env: {'DISPLAY': ':0', 08:36:10 INFO - 'HOME': '/home/cltbld', 08:36:10 INFO - 'LANG': 'en_US.UTF-8', 08:36:10 INFO - 'LANGUAGE': 'en_US:en', 08:36:10 INFO - 'LOGNAME': 'cltbld', 08:36:10 INFO - 'MAIL': '/var/mail/cltbld', 08:36:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:10 INFO - 'MOZ_NO_REMOTE': '1', 08:36:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:10 INFO - 'NO_EM_RESTART': '1', 08:36:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:10 INFO - 'PWD': '/builds/slave/test', 08:36:10 INFO - 'SHELL': '/bin/bash', 08:36:10 INFO - 'SHLVL': '1', 08:36:10 INFO - 'TERM': 'linux', 08:36:10 INFO - 'TMOUT': '86400', 08:36:10 INFO - 'USER': 'cltbld', 08:36:10 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1469201741.255-1261785442', 08:36:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:10 INFO - '_': '/tools/buildbot/bin/python'} 08:36:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:36:10 INFO - Running setup.py (path:/tmp/pip-QRCHNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:36:10 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)) 08:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:36:10 INFO - Running setup.py (path:/tmp/pip-SVn4iV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:36:10 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)) 08:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:36:10 INFO - Running setup.py (path:/tmp/pip-Jy0Q7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:36:10 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)) 08:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:36:10 INFO - Running setup.py (path:/tmp/pip-dGC0t6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:36:10 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)) 08:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:36:10 INFO - Running setup.py (path:/tmp/pip-vB9a9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:36:11 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)) 08:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:36:11 INFO - Running setup.py (path:/tmp/pip-QFf4GM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:36:11 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)) 08:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:36:11 INFO - Running setup.py (path:/tmp/pip-rmut4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:36:11 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)) 08:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:36:11 INFO - Running setup.py (path:/tmp/pip-FhYMk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:36:11 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)) 08:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:36:11 INFO - Running setup.py (path:/tmp/pip-M5rfOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:36:11 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)) 08:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:36:11 INFO - Running setup.py (path:/tmp/pip-QlBXIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:36:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 08:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:36:11 INFO - Running setup.py (path:/tmp/pip-X9rIHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:36:11 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)) 08:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:36:11 INFO - Running setup.py (path:/tmp/pip-mbnGWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:36:11 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)) 08:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:36:11 INFO - Running setup.py (path:/tmp/pip-UzmPtS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:36:11 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)) 08:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:36:11 INFO - Running setup.py (path:/tmp/pip-7gkMxd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:36:11 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)) 08:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:36:11 INFO - Running setup.py (path:/tmp/pip-TicExa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:36:11 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)) 08:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:36:11 INFO - Running setup.py (path:/tmp/pip-PQn7ds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:36:11 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)) 08:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:36:11 INFO - Running setup.py (path:/tmp/pip-mSnqTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:36:11 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)) 08:36:11 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)) 08:36:11 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)) 08:36:11 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)) 08:36:11 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)) 08:36:11 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)) 08:36:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:36:11 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 08:36:11 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 08:36:11 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 08:36:11 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 08:36:11 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 08:36:11 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 08:36:13 INFO - Downloading blessings-1.6.tar.gz 08:36:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:36:13 INFO - Installing collected packages: blessings 08:36:13 INFO - Running setup.py install for blessings 08:36:14 INFO - Successfully installed blessings 08:36:14 INFO - Cleaning up... 08:36:14 INFO - Return code: 0 08:36:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:36:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:36:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:36:14 INFO - Reading from file tmpfile_stdout 08:36:14 INFO - Current package versions: 08:36:14 INFO - argparse == 1.2.1 08:36:14 INFO - blessings == 1.6 08:36:14 INFO - blobuploader == 1.2.4 08:36:14 INFO - docopt == 0.6.1 08:36:14 INFO - functools32 == 3.2.3-2 08:36:14 INFO - jsonschema == 2.5.1 08:36:14 INFO - manifestparser == 1.1 08:36:14 INFO - mozInstall == 1.12 08:36:14 INFO - mozcrash == 0.17 08:36:14 INFO - mozdebug == 0.1 08:36:14 INFO - mozdevice == 0.48 08:36:14 INFO - mozfile == 1.2 08:36:14 INFO - mozhttpd == 0.7 08:36:14 INFO - mozinfo == 0.9 08:36:14 INFO - mozleak == 0.1 08:36:14 INFO - mozlog == 3.3 08:36:14 INFO - moznetwork == 0.27 08:36:14 INFO - mozprocess == 0.23 08:36:14 INFO - mozprofile == 0.28 08:36:14 INFO - mozrunner == 6.12 08:36:14 INFO - mozscreenshot == 0.1 08:36:14 INFO - mozsystemmonitor == 0.3 08:36:14 INFO - moztest == 0.7 08:36:14 INFO - mozversion == 1.4 08:36:14 INFO - psutil == 3.1.1 08:36:14 INFO - requests == 1.2.3 08:36:14 INFO - wsgiref == 0.1.2 08:36:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:36:14 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')]} 08:36:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:14 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')]} 08:36:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:14 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 0x242f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ee3b0>, '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 0x26ef2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ef740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1469201741.255-1261785442', '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 08:36:14 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 08:36:14 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 08:36:14 INFO - Using env: {'DISPLAY': ':0', 08:36:14 INFO - 'HOME': '/home/cltbld', 08:36:14 INFO - 'LANG': 'en_US.UTF-8', 08:36:14 INFO - 'LANGUAGE': 'en_US:en', 08:36:14 INFO - 'LOGNAME': 'cltbld', 08:36:14 INFO - 'MAIL': '/var/mail/cltbld', 08:36:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:14 INFO - 'MOZ_NO_REMOTE': '1', 08:36:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:14 INFO - 'NO_EM_RESTART': '1', 08:36:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:14 INFO - 'PWD': '/builds/slave/test', 08:36:14 INFO - 'SHELL': '/bin/bash', 08:36:14 INFO - 'SHLVL': '1', 08:36:14 INFO - 'TERM': 'linux', 08:36:14 INFO - 'TMOUT': '86400', 08:36:14 INFO - 'USER': 'cltbld', 08:36:14 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1469201741.255-1261785442', 08:36:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:14 INFO - '_': '/tools/buildbot/bin/python'} 08:36:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:14 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)) 08:36:14 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)) 08:36:14 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)) 08:36:14 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)) 08:36:14 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)) 08:36:14 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)) 08:36:14 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)) 08:36:14 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)) 08:36:14 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)) 08:36:14 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)) 08:36:14 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)) 08:36:14 INFO - Cleaning up... 08:36:14 INFO - Return code: 0 08:36:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:36:14 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')]} 08:36:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:14 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')]} 08:36:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:14 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 0x242f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ee3b0>, '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 0x26ef2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ef740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1469201741.255-1261785442', '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 08:36:14 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 08:36:14 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 08:36:14 INFO - Using env: {'DISPLAY': ':0', 08:36:14 INFO - 'HOME': '/home/cltbld', 08:36:14 INFO - 'LANG': 'en_US.UTF-8', 08:36:14 INFO - 'LANGUAGE': 'en_US:en', 08:36:14 INFO - 'LOGNAME': 'cltbld', 08:36:14 INFO - 'MAIL': '/var/mail/cltbld', 08:36:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:14 INFO - 'MOZ_NO_REMOTE': '1', 08:36:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:14 INFO - 'NO_EM_RESTART': '1', 08:36:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:14 INFO - 'PWD': '/builds/slave/test', 08:36:14 INFO - 'SHELL': '/bin/bash', 08:36:14 INFO - 'SHLVL': '1', 08:36:14 INFO - 'TERM': 'linux', 08:36:14 INFO - 'TMOUT': '86400', 08:36:14 INFO - 'USER': 'cltbld', 08:36:14 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1469201741.255-1261785442', 08:36:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:14 INFO - '_': '/tools/buildbot/bin/python'} 08:36:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:36:14 INFO - Cleaning up... 08:36:14 INFO - Return code: 0 08:36:14 INFO - Running post-action listener: _resource_record_post_action 08:36:14 INFO - Running post-action listener: _start_resource_monitoring 08:36:14 INFO - Starting resource monitoring. 08:36:14 INFO - [mozharness: 2016-07-22 15:36:14.762934Z] Finished create-virtualenv step (success) 08:36:14 INFO - [mozharness: 2016-07-22 15:36:14.763364Z] Running install step. 08:36:14 INFO - Running pre-action listener: _resource_record_pre_action 08:36:14 INFO - Running main action method: install 08:36:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:36:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:36:14 INFO - Reading from file tmpfile_stdout 08:36:14 INFO - Detecting whether we're running mozinstall >=1.0... 08:36:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:36:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:36:15 INFO - Reading from file tmpfile_stdout 08:36:15 INFO - Output received: 08:36:15 INFO - Usage: mozinstall [options] installer 08:36:15 INFO - Options: 08:36:15 INFO - -h, --help show this help message and exit 08:36:15 INFO - -d DEST, --destination=DEST 08:36:15 INFO - Directory to install application into. [default: 08:36:15 INFO - "/builds/slave/test"] 08:36:15 INFO - --app=APP Application being installed. [default: firefox] 08:36:15 INFO - mkdir: /builds/slave/test/build/application 08:36:15 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'] 08:36:15 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 08:36:31 INFO - Reading from file tmpfile_stdout 08:36:31 INFO - Output received: 08:36:31 INFO - /builds/slave/test/build/application/firefox/firefox 08:36:31 INFO - Running post-action listener: _resource_record_post_action 08:36:31 INFO - [mozharness: 2016-07-22 15:36:31.431047Z] Finished install step (success) 08:36:31 INFO - [mozharness: 2016-07-22 15:36:31.431324Z] Running run-tests step. 08:36:31 INFO - Running pre-action listener: _resource_record_pre_action 08:36:31 INFO - Running main action method: run_tests 08:36:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:36:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:36:31 INFO - Python 2.7.3 08:36:31 INFO - Return code: 0 08:36:31 INFO - grabbing minidump binary from tooltool 08:36:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:36:31 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 0x26ee3b0>, '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 0x26ef2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ef740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:36:31 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 08:36:31 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 08:36:31 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 08:36:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:36:31 INFO - Return code: 0 08:36:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:36:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:36:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:36:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:36:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:36:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TjzSkRXaSjOvNfAcPzLQ7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:36:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TjzSkRXaSjOvNfAcPzLQ7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:36:31 INFO - Using env: {'DISPLAY': ':0', 08:36:31 INFO - 'HOME': '/home/cltbld', 08:36:31 INFO - 'LANG': 'en_US.UTF-8', 08:36:31 INFO - 'LANGUAGE': 'en_US:en', 08:36:31 INFO - 'LOGNAME': 'cltbld', 08:36:31 INFO - 'MAIL': '/var/mail/cltbld', 08:36:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:36:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:36:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:31 INFO - 'MOZ_NO_REMOTE': '1', 08:36:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:36:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:31 INFO - 'NO_EM_RESTART': '1', 08:36:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:31 INFO - 'PWD': '/builds/slave/test', 08:36:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:36:31 INFO - 'SHELL': '/bin/bash', 08:36:31 INFO - 'SHLVL': '1', 08:36:31 INFO - 'TERM': 'linux', 08:36:31 INFO - 'TMOUT': '86400', 08:36:31 INFO - 'USER': 'cltbld', 08:36:31 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1469201741.255-1261785442', 08:36:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:31 INFO - '_': '/tools/buildbot/bin/python'} 08:36:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TjzSkRXaSjOvNfAcPzLQ7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:36:31 INFO - mozversion application_buildid: 20160722080026 08:36:31 INFO - mozversion application_changeset: ff29f08b72c466b65dea5efa6f82f99add8f17ef 08:36:31 INFO - mozversion application_display_name: Nightly 08:36:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:36:31 INFO - mozversion application_name: Firefox 08:36:31 INFO - mozversion application_remotingname: firefox 08:36:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:36:31 INFO - mozversion application_vendor: Mozilla 08:36:31 INFO - mozversion application_version: 50.0a1 08:36:31 INFO - mozversion platform_buildid: 20160722080026 08:36:31 INFO - mozversion platform_changeset: ff29f08b72c466b65dea5efa6f82f99add8f17ef 08:36:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:36:31 INFO - mozversion platform_version: 50.0a1 08:36:31 INFO - using testdate: 1469201791 08:36:31 INFO - actual date: 1469201791 08:36:31 INFO - starting webserver on 'localhost:33253' 08:36:31 INFO - SUITE-START | Running 2 tests 08:36:31 INFO - TEST-START | dromaeo_css 08:36:31 INFO - operating with platform_type : linux_ 08:36:31 INFO - Initialising browser for dromaeo_css test... 08:36:31 INFO - TEST-INFO | started process 10197 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAJ0gWg/profile http://localhost:33253/getInfo.html) 08:36:35 INFO - PROCESS | 10197 | JavaScript error: , line 0: uncaught exception: undefined 08:36:36 INFO - PROCESS | 10197 | __metrics Screen width/height:1600/1200 08:36:36 INFO - PROCESS | 10197 | colorDepth:24 08:36:36 INFO - PROCESS | 10197 | Browser inner width/height: 1024/697 08:36:36 INFO - PROCESS | 10197 | __metrics 08:36:37 INFO - PROCESS | 10197 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:36:37 INFO - PROCESS | 10197 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:36:37 INFO - PROCESS | 10197 | console.error: PushService: 08:36:37 INFO - PROCESS | 10197 | stateChangeProcessEnqueue: Error transitioning state 08:36:37 INFO - PROCESS | 10197 | UnknownError 08:36:38 INFO - TEST-INFO | 10197: exit 0 08:36:38 INFO - Browser initialized. 08:36:38 INFO - Running cycle 1/1 for dromaeo_css test... 08:36:38 INFO - TEST-INFO | started process 10277 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAJ0gWg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:36:50 INFO - PROCESS | 10277 | RSS: Main: 159170560 08:36:50 INFO - PROCESS | 10277 | 08:37:41 INFO - PROCESS | 10277 | 1469201861867 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] 08:39:54 INFO - PROCESS | 10277 | Cycle 1(1): loaded http://localhost:33253/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33253/tests/dromaeo/cssquery-ext.html) 08:39:55 INFO - PROCESS | 10277 | RSS: Main: 257814528 08:39:55 INFO - PROCESS | 10277 | 08:42:58 INFO - PROCESS | 10277 | Cycle 1(1): loaded http://localhost:33253/tests/dromaeo/cssquery-ext.html (next: http://localhost:33253/tests/dromaeo/cssquery-jquery.html) 08:42:58 INFO - PROCESS | 10277 | RSS: Main: 244903936 08:42:58 INFO - PROCESS | 10277 | 08:46:00 INFO - PROCESS | 10277 | Cycle 1(1): loaded http://localhost:33253/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33253/tests/dromaeo/cssquery-mootools.html) 08:46:01 INFO - PROCESS | 10277 | RSS: Main: 207663104 08:46:01 INFO - PROCESS | 10277 | 08:49:03 INFO - PROCESS | 10277 | Cycle 1(1): loaded http://localhost:33253/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33253/tests/dromaeo/cssquery-prototype.html) 08:49:04 INFO - PROCESS | 10277 | RSS: Main: 186048512 08:49:04 INFO - PROCESS | 10277 | 08:52:07 INFO - PROCESS | 10277 | Cycle 1(1): loaded http://localhost:33253/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33253/tests/dromaeo/cssquery-yui.html) 08:52:08 INFO - PROCESS | 10277 | RSS: Main: 185425920 08:52:08 INFO - PROCESS | 10277 | 08:55:11 INFO - PROCESS | 10277 | Cycle 1(1): loaded http://localhost:33253/tests/dromaeo/cssquery-yui.html (next: http://localhost:33253/tests/dromaeo/cssquery-dojo.html) 08:55:11 INFO - PROCESS | 10277 | RSS: Main: 278691840 08:55:11 INFO - PROCESS | 10277 | 08:55:11 INFO - PROCESS | 10277 | __start_tp_report 08:55:11 INFO - PROCESS | 10277 | _x_x_mozilla_page_load 08:55:11 INFO - PROCESS | 10277 | _x_x_mozilla_page_load_details 08:55:11 INFO - PROCESS | 10277 | |i|pagename|runs| 08:55:11 INFO - PROCESS | 10277 | |0;dojo.html;2576.0597381955586;2579.5614745493262;2614.973850261497;2622.881970311336;2625.5405304071783;4583.335416364625;4642.094791515648;4679.672422930396;4699.90600187996;4702.835400760974;4671.39271894654;4690.835820746274;4716.292556116584;4742.6205903527725;4759.857204283869;4311.094670119279;4360.956390436103;4363.978180109095;4377.255866502702;4394.824207031715;4332.1335732853395;4404.845830395937;4448.488423831269;4464.5981861632445;4485.327200919855;4420.3369494575745;4437.955620443787;4477.977610111945;4486.327050942368;4493.41585593874;4198.916021679549;4253.489581250239;4264;4378.8029538670835;4384.408104905829;4251.3622956556455;4268.445102136733;4305.590968857985;4312.935305970413;4373.343998400265;4652.976735116336;4700.271457924027;4722.362481065081;4744.454387745419;4767.856964291077;5085.491450854922;5089.083964886319;5092.2361645753435;5093.847184584469;5103.336566246401;4924.852254432372;4996;5031.195008798574;5079.4412614612365;5139.691618502902;4766.404199475066;4772.427308722976;4781.545753153445;4787.808487660524;4797.088553174885;5256.710880901511;5259.47405259471;5264.52619264268;5267.157254839208;5270.78916843322;4774.4509381421585;4895.31465594817;4963.8014479421145;4967.05625931072;4999.42506611737;5060.114479966065;5060.898782024413;5099.694018358836;5103.489651034941;5107.923381149286;5006.224035274538;5006.4743201964;5011.924821127686;5013;5055.69665820052;4783.7129772213775;4837.05677392905;4844.539768721966;4869.829555965524;4870.878228044327;4204.348326009474;4223.915521689549;4250.404943307939;4260.701750877409;4317.244482215662;3716.3496388132507;3719.8326075326677;3722.1253005543676;3754.9436758448646;3762.435634654824;4344.4352234209355;4359.869203923888;4363.869083927487;4405.229084910128;4406.030673251879;4883.755812209375;4987.850364489072;5033.5469807716745;5061.544460998528;5093.18509038552;4322.589354011427;4322.740635561876;4360.585744354345;4367.71609845359;4413.271810151353;4508.639308855284;4512.9097418052115;4515.571020753023;4555.407796986437;4578.5421457853945;4616.146012987608;4623.88440288982;4658.464276608233;4739.763011849463;4744.739039352799;4999.175136102648;5006.173981293192;5007.198848184273;5046.066477701637;5050.924236136388;4647.883802904955;4682.461516925598;4682.601978831701;4683.063387322617;4727.030958653399;4840.7337596432535;4876.024795040935;4883.87790305231;4918.458969513422;4973.875653108556;5015.874603134951;5020.949790502048;5038.647294689336;5044.117279476003;5084.313617661568;4908.11653902301;4916.582090522203;4922.827701030446;4923.753812309442;4970.62720295972;4778.33103365536;4850.296706977398;4888.266759985889;4917.1149193145575;4971.304017437489;4830.961343311205;4831.057943701085;4844.515548445268;4845.927311090266;4852.73309967941;4910.975445122752;4938.111139994836;4947.406311242674;4947.752612369439;4954.3311652926395;4679.344891715231;4721.622270218306;4786.664933454625;4833.32333473307;4866.8053277868485 08:55:11 INFO - PROCESS | 10277 | |1;ext.html;546.3490913251588;582.7202942587555;590.1619700025963;598.6408155106936;604.3141034925361;26017.089401870915;38452;39805;39935.60064399355;39971.400428993555;39589.604103958955;39896.20207595846;39975;39988.60011399885;40030.59969400305;7800.648970796314;7939.047314322261;7943.165967573408;7950.403719721044;7950.602469876512;7540.434467414966;10023.498825058754;10321.741956451073;10322.122619577307;10676.092532134779;10325.225608079387;10414.11480024195;10421.69728783902;10426.322289051188;10428.16574674028;10266.538005789758;10267.589296428208;10321.483925803679;10339.896601033968;10349.379037257788;9859.950700246525;10085.747856303578;10089;10089;10095.444750538718;36726.81636591827;36786.448203276974;37037;37100.628993710256;37132.44301335482;2893.56596510523;3060.853995175445;3094.582231398755;3147.685231476857;3198.3123628420003;28785.136445906657;28859.85570072157;29027.419451611062;29104.41791164186;29134.41731165386;3225.709686128236;3248.658890816454;3301.8018918864946;3318.369509793132;3333.383324085052;202946;261837.69081154664;262067;262124;262333;54627.453725463034;55300.446995530336;55301.44698552963;55348.72325638346;55364.44635553673;32863.342733145204;33467.49798753021;33640;35441.34189935765;35442.64557354445;15639;15791.763123553155;15797.763033554505;15821.208939552977;15823.208839558207;10961.287516311415;11664.6500604982;11678.70803229926;11760.94119529414;11769.705757356134;17565;18220.271189152285;18314.26742930268;18316.63366732658;18486;6838.855915774436;6967.407770339578;6980.289828991929;7058.153021637437;7138.357547820721;775.0389516998881;840.6553313141704;860.2129051917425;860.5095095795336;905.2848249882519;24197.15309964143;25912.22263332103;26071.478570428484;26102.86948565245;26417.07540236121;954.5084281594984;971.8764499568324;986.2800155886243;1025.9692209233735;1072.8176210044312;13445.394957226948;14151.929240353733;14212.502562410265;14295.142291462545;14389.568312950629;371302;378529;378961;379683;380813;49316.75341623269;49764.75117624461;49769;49780.253296200586;49919.50080499148;1100.4167791070745;1113.5935383584933;1157.1379322404862;1176.564671071709;1219.2806244315896;26156.73843261543;28977.42045159127;29199.562006569493;29229.01261960222;30090.69909300879;41797.79101104475;42371.78814106033;42385.36421953735;42389.36415953825;42402.36396453994;294215;296750;296787;297413;297930;24890;25493.74506254988;25523;25597.488050238517;26743.465130696888;41137.79431102825;41268.79365603153;41666.58333416627;42082.579174207865;42564.36153457639;35870.10324741902;35990.46014309735;36057.45913811243;36737.448938265414;36760.08099797527;35150.824245878604;35472.82263588665;36102.8194859024;36449;36540.81729591335;35302.29395412129;35318.64681353256;35320;35745.1063723409;35796.64203357933;31209.84395078101;32558;32572.67427325791;32635;32718.182045449055;25110.49779004373;25217.87391063033;25273.368165796;25433.364165896;25476 08:55:11 INFO - PROCESS | 10277 | |2;jquery.html;348.6861824358079;363.9363111455496;369.8742427574624;370.9666130048296;388.6812813492935;12636.68408289792;16423.671526569462;16571.08859012754;16648.583785405357;17449.04030278334;16439.178041097955;16958.40645577405;17549;17615;17692.38076667317;5079.720615366154;5084.339035925324;5204.193350030732;5209.32278803755;5257.553107985826;3766.152615661482;5261.39493958194;5347.411784703699;5899.144624029514;6214.564980451348;6237.812865614039;6290.622562646233;6308.684565771693;6309.9369006310035;6316.905246421307;5965.164876917235;6202.658853763041;6237.313895471494;6249.312575616678;6293.559450838443;4839.104765618372;5457.2359869618285;5466.699331536764;5468.7539060741965;5471.261379713767;11175.21773475857;11625.418729063598;11679.7080072998;11768.293902365886;11796.528138874435;1754.5175076853968;1799.874008819383;1889.3009586452963;1897.4212865076147;1932.3623204342534;9015.909840901573;9182.816343673156;9313.860292095624;9447.716568502956;9858.80282394348;1699.8555122814575;1777.111444277861;1794.246416505071;1794.2733193056833;1807.295154889581;70470;72194;72673.63663181651;73031.26968730298;73116;10075.647352342632;10101.494925253708;10128.54421551032;10440.269181157399;10467.424291664032;14006;14013.089149205269;14019.789703154462;14028.579142625738;14052;7309.744158954411;7531.623418829036;7602.46782725204;7727.5749833758555;7738.806529836686;7302.525335853153;7312.561246325237;7495.66269517873;7501.324880760649;7535.359494442924;4313.827446902152;4396.4064851244675;4404.537523560044;4488.573585509372;4507.143642707875;1843.5298998755231;1853.6570734413906;1856.950822785149;1874.0816999670335;1904.1716853168916;687.5737043033251;689.6757628231874;747.4618274842105;793.765839077462;845.159066728609;16915.407960721317;17361.65276694459;17510.29958801659;17684;17944.641107177784;793.4445887878508;863.6113748813059;886.9467831930104;905.3345790843724;906.6781292641017;9467.66863159786;9639.277054220962;9722.659706910366;9999.100080992746;10196.4391958443;393968;395357.02321488207;398749;399729;399957;72590;78857.02857428495;79424.60287698524;80417.59791201123;81084;905.9954700226325;921.1157289002632;943.7451887990342;944.8724422203052;947.4552132523827;16377.181140943143;16569.502914912573;17026.489205323862;17153.74269385985;17297;38530.22939541138;38585.237738247095;38591;39170;39547.4294170878;53432.46567534275;53900.19149712679;54687.63280918009;55784.72107639436;56037;6652.667366631552;7514.774556763306;7716.344110750649;7860.567668778043;7896.526208427513;9008.504532250789;11978.58074967372;12212.633620991384;12424.813627795771;12585.685357866127;9734.659286924923;9875.308728388944;10090.19278457707;10508.947455262674;10549.630762923261;9925.900740992498;10398.792024159324;10420.374777513374;10434.895651043393;10461.790764184521;10108.949455252676;10250.794984100126;10275.897241027793;10344.896551034393;10555.208359373231;7380.557166570023;7520.811979700551;7740.651670674721;7790.922090779246;7901.68393264263;9373;10103;10204.744881378025;10275.383476991405;10399.792004159723 08:55:11 INFO - PROCESS | 10277 | |3;mootools.html;1392.937317820698;1437.0156442836658;1491.7314883320998;1671.9582010449744;1699.1249506504153;7595.240475952409;8072.677092916284;8075.596220188996;8084.7978800529945;8087.150849160842;6883.759068432606;7076.964615176929;7715.498492597977;7912.723054693087;7923.445358824884;2147.1518750093705;2170.1861801824316;2175.0755928730305;2179.3135162423864;2179.4660308224506;2027.543802644408;2068.7620923593754;2094.685797130435;2096.5911647228795;2097.1820989813987;1821.6720990221754;2062.7009083682856;2138.3264271754424;2138.77542858;2142.9035693393835;2122.5754849030177;2137.7434707835005;2143;2146.9355919322447;2158.2338269914267;2183.159483598826;2207.0399376271375;2207.9006444709867;2208.3374987503844;2211.0381983836924;7825.804354891174;7873.370130389555;7876.133625301212;7880.684772609089;7887.645055972495;4550.68145229834;4687.484376718558;4694.436667599875;4696.483386827446;4700.929486057712;2718.3418114949864;2902.1438675590753;2903.0855280586547;2911.199420159452;2916.402137561795;853.3599800149888;894.7002754077392;904.4754042655244;912.3704643795826;914.7758799094198;10550.050495455369;10813.729656758487;10822.134229261641;10842.403667798268;10844.566217351297;4027.8993025174605;4120.938185927213;4259.0204253021975;4262.42457268271;4266.530681625019;9273.58268877902;9312.813743725223;9320.067993200626;9327.393719408217;9337.439753614804;4708.411448568929;4712.128256272601;4713.905721885543;4716.787744551503;4717.315989181549;4038.495188101487;4180.581941805795;4215.220184265921;4221.197972385237;4227.387028880795;3512.5784905811465;3578.570571531433;3631.4008188649104;3637.5089362936196;3694.556653201633;1082.5020490574425;1096.0628662493612;1096.819024860905;1101.6474728086935;1118.5134466507095;589.3634874335793;653.9346065393518;750.6847124207845;782.1357400072951;790.9841803163904;5160.303359046556;5278.736063196825;5336.973315133399;5366.812161574404;5475.123980163155;850.6639877248576;861.5993562993239;885.2784980241083;887.6050157679899;893.1648908270788;3452.171478845059;3514.279572687593;3520.207953210507;3556.2354093869944;3614.8734794282072;9171.954140229256;9629.133377995873;9695.03049695039;9700.660476883417;9711.708648740549;9468.57391417388;9783.46190959504;9821.607135714634;9845;9876.111149996535;7178.784636460915;7292.489525733254;7307.853842923112;7311.488195826241;7368.815779605553;4959;4966.975165124151;5030.6730062547285;5276.551493123127;5335.813246536352;8840.292776577988;9014.143656352637;9082.909170908471;9144.314176436661;9210;8817.867731983897;9106.134917182857;9173.724788256362;9213.539323033956;9246.4914429707;7247.746328878464;7452.478326517092;7642.5032372895585;7644.426667999811;7647.541147531166;7552.320291173821;7555.282248186413;7560.470767046254;7563.168051514439;7631.885521717068;6671.366220209073;6679.732810687518;6773.18721753373;6787.728490860311;6882.346177113166;6647.268800431852;6688.464922806261;6734.730610775514;6790.898136527857;6885.793426197222;6001.7299221536005;6149.784757533644;6162.907556386747;6173.444390004921;6187.350328215653;4516.525764794649;4574.5425457453985;4612.054528821516;4617.007343421181;4734.644901632322;4550.6587005974025;4575.9771201143785;4600.654950878765;4602.516735742699;4698.788554514987 08:55:11 INFO - PROCESS | 10277 | |4;prototype.html;292.88870229312863;297.064247619997;301.6305026342729;302.5748822903821;305.1410280061627;4900.828471003516;4905.583025442837;4932.531409516095;4938.629602779797;4951.3810773653295;4814.7351895645725;4827.903441931159;4886.291487734276;4897.191963326056;4897.559219670229;3547.822608869559;3675.4854320395166;3677.760945538545;3814.179951310468;3835.712321575879;3804.7526910750853;3810.637989391017;3814.866479673212;3840.2127563849344;3847.634474724897;3766.6045065268163;3771.1326394929183;3782.829772660237;3787.3561494545856;3806.657400833938;3481.756277060607;3522.1722895119497;3653.707703383723;3664.2121943782213;3778.9622103779025;3322.235885746292;3326.6340702522702;3346.8493917773517;3362.411577973845;3372.173817414749;4652.883677908079;4667.813287468532;4678.532146785295;4702.271147972036;4720.150372932871;4236.707804119742;4353.0423306872435;4358.716683415568;4360.106178233455;4366.454193225847;4986.501349864984;4997.075541024886;5019.272205530177;5053.393592768854;5080.237964305384;3652.251288485854;3665.87169449068;3680.355937710917;3681.061329360996;3686.447032945053;5142.5628821549835;5311.2298716686255;5349.625526213166;5355.892882142335;5356.785728570852;3670.6879915206973;3671.7796932184156;3685.8157092145284;3708.276886007203;3711.7958512282084;3738.9626103738615;3741.9438708419398;3756.7745935243424;3768.4535742317757;3782.829772660237;4268.658507319469;4269.3595960605535;4282.550332215073;4287.399764033038;4310.159518893848;4859.271109333628;5006.0989021975665;5022.949770502321;5030.270610761419;5046.571041461443;1292.9224246545236;1314.1786383510307;1320.9867901320863;1323.8146659467682;1325.1055537512334;816.9060558035783;850.5534594337898;855.9786005349916;872.6640243506168;879.8944126704708;3978.647259931637;3986.5016872890887;4238.936415953764;4364.1708075466195;4400.44994375703;5197.948020519746;5205.984832957537;5206.297149884793;5208.427073021964;5210.6613070150315;4450.866474005785;4451.910961780811;4461.442319710036;4494.168578812864;4494.573015563582;2594.4811037792515;2737.7536021758137;2753.655793025872;2758.3517873299757;2758.4207316463367;4859.2954021666665;4870.172070747911;4896.4858689837765;4905.681130726492;4906.779194936236;5334.67991920486;5340.25236466895;5350.143976963667;5364.195370694427;5371.543418809445;4677.508861569554;4876.731779752147;4897.363342765418;4937;4943.752812359439;5247.1866860636665;5268.947310526845;5270.525652691276;5273.602495338815;5291.973540132275;5117.385913690381;5194.714290714047;5196.896062078813;5197.480251974772;5216.686998780086;4695.4834968154155;4888.291197776373;4908.214685650421;4912.680675756064;4914.926276105933;3680.153564680085;3704.407294832814;3706.62933706638;3715.9256814864093;3731.5708693500596;5290.523852853262;5320.787168513216;5320.946790532045;5328.17413300939;5331.546818520469;4960.8759781005765;5048.293238946477;5129.820456284012;5138.614603904647;5140.074786538459;5052.115879721107;5074.238864170404;5079.596670231028;5088.491150884882;5100.209467532539;4995.302536630179;5001.1498045331655;5028.2960385546785;5056.191009438472;5059.898802023865;4871.732054737024;4889.828855990166;5104.846854594368;5117.565006974449;5124.359455068116;4837.016823102511;4981.327520784647;5000.099982003274;5009.223570346602;5011.7494125294315 08:55:11 INFO - PROCESS | 10277 | |5;yui.html;649.9935000649994;675.567636712504;705.3510770091515;730.9963450182752;746.6640011994602;11800.760920103394;12458.501659933603;12522.624321270365;12538.49846006161;12540.435680394381;13390.397432115555;13505.257210853424;13533.188008719459;13539.323033848294;13621.978351623644;620.9844753881144;745.3813334931993;759.2786852490129;770.3567521119871;771.9112302085276;766.7086507127311;768.9653965571534;773.0916173496148;776.5845272779064;779.793354760986;816.5590581086207;819.2994989284166;819.7253919936828;819.9344052475788;819.9467034642729;639.0892977507057;658.6969993802857;663.8838203314401;668.8194187569329;809.4131754478016;579.7738881836087;588.5497594340333;592.2034863109111;593.2643522032648;594.2749845188863;12977.805332920014;13063.412146453433;13068.215907045513;13073.280969546671;13107.47570097195;11576.53693852245;11790.469428875722;12060.155789094679;12084.758304833855;12539.93730031344;9975.401475911469;10167;11409.087273018138;11457.312561246352;11496.137789665809;3972.543157536891;4030.979845100785;4114.979425102885;4192.832286708528;4212.85255016073;49265.26102108471;51599.22601161023;61502;61663;62096.37903620996;10110.747231319128;10359.119474844572;10476.895231047745;10510.527026283835;10691.198160138021;18321.7251741224;18376.264949402143;18393.172307246205;18395.080245987647;18395.26418943254;6870.587764734132;6887.031823350389;7051.5063945523325;7105.857882842418;7169.89245161323;3520.6655367740536;3586.4082426399873;3611.9336136753627;3612.5303710517464;3686;2866.9856650716615;2949.8672559734864;2955.7783166262616;2960.18594886408;2961.4077184563175;495.0519754669767;509.38110196111904;512.0884825011411;515.1474310016928;518.9714565698923;519.9038177937093;521.7599904044106;577.9133130030528;583.582738342079;598.9608030067828;7771.212007878901;7905.604719764104;7935.920640793518;8211.630476628567;8269.46248493846;479.5875547029552;570.4751628501788;595.8778450417655;609.6860117039728;611.7858749437661;3721.14413684854;3802.16352402471;3837.194189220239;3882.417637354363;3961.1087505311652;53984;79109.20890791134;89277;98719;99354.50322748485;80740;81305.59347203345;81345.18654813494;82648.58675706583;84356.57821710852;72293;72626.63686681533;73153.6342318285;74530;74578;7822.765317040498;8014;8042.597870106589;8194.42639015287;8225.218604232588;33543.49684754682;39245.41131882967;41006.384904225866;44828.32757508575;47153;63219.68390158204;63287;63479.6826015867;63483;65920;9936.354136981074;10432.321899076536;10797.514111865143;10895.07391871668;10910.959348295522;12866.67833304175;12928.516067489732;13156.079074464695;13278.402471888596;13281.601551953458;10885.78228435411;10926.399048052433;11371.090312775124;11921.046316294849;11967.042636588878;9582.425054496753;9658.855117173107;9735.269854761063;9755.317127800985;9828.361156524803;11543.36511491876;11637.941810290895;11942.522299107939;12358.752824943631;12439.689007774878;8785.560721963748;8792;9051.411658242194;9995.300328976902;10057.69826905194;8657.052163263215;8982.236509896731;9409.106134917172;9446.574904129193;9557.283203759607 08:55:11 INFO - PROCESS | 10277 | __end_tp_report 08:55:11 INFO - PROCESS | 10277 | __start_cc_report 08:55:11 INFO - PROCESS | 10277 | _x_x_mozilla_cycle_collect,950 08:55:11 INFO - PROCESS | 10277 | __end_cc_report 08:55:11 INFO - PROCESS | 10277 | __startTimestamp1469202911542__endTimestamp 08:55:11 INFO - PROCESS | 10277 | 08:55:11 INFO - PROCESS | 10277 | ------- Summary: start ------- 08:55:11 INFO - PROCESS | 10277 | Number of tests: 6 08:55:11 INFO - PROCESS | 10277 | 08:55:11 INFO - PROCESS | 10277 | [#0] dojo.html Cycles:165 Average:4652.84 Median:4767.86 stddev:486.51 (10.2%) stddev-sans-first:459.91 08:55:11 INFO - PROCESS | 10277 | Values: 2576.1 2579.6 2615.0 2622.9 2625.5 4583.3 4642.1 4679.7 4699.9 4702.8 4671.4 4690.8 4716.3 4742.6 4759.9 4311.1 4361.0 4364.0 4377.3 4394.8 4332.1 4404.8 4448.5 4464.6 4485.3 4420.3 4438.0 4478.0 4486.3 4493.4 4198.9 4253.5 4264.0 4378.8 4384.4 4251.4 4268.4 4305.6 4312.9 4373.3 4653.0 4700.3 4722.4 4744.5 4767.9 5085.5 5089.1 5092.2 5093.8 5103.3 4924.9 4996.0 5031.2 5079.4 5139.7 4766.4 4772.4 4781.5 4787.8 4797.1 5256.7 5259.5 5264.5 5267.2 5270.8 4774.5 4895.3 4963.8 4967.1 4999.4 5060.1 5060.9 5099.7 5103.5 5107.9 5006.2 5006.5 5011.9 5013.0 5055.7 4783.7 4837.1 4844.5 4869.8 4870.9 4204.3 4223.9 4250.4 4260.7 4317.2 3716.3 3719.8 3722.1 3754.9 3762.4 4344.4 4359.9 4363.9 4405.2 4406.0 4883.8 4987.9 5033.5 5061.5 5093.2 4322.6 4322.7 4360.6 4367.7 4413.3 4508.6 4512.9 4515.6 4555.4 4578.5 4616.1 4623.9 4658.5 4739.8 4744.7 4999.2 5006.2 5007.2 5046.1 5050.9 4647.9 4682.5 4682.6 4683.1 4727.0 4840.7 4876.0 4883.9 4918.5 4973.9 5015.9 5020.9 5038.6 5044.1 5084.3 4908.1 4916.6 4922.8 4923.8 4970.6 4778.3 4850.3 4888.3 4917.1 4971.3 4831.0 4831.1 4844.5 4845.9 4852.7 4911.0 4938.1 4947.4 4947.8 4954.3 4679.3 4721.6 4786.7 4833.3 4866.8 08:55:11 INFO - PROCESS | 10277 | 08:55:11 INFO - PROCESS | 10277 | [#1] ext.html Cycles:180 Average:46138.79 Median:32603.84 stddev:82199.09 (252.1%) stddev-sans-first:82358.40 08:55:11 INFO - PROCESS | 10277 | Values: 546.3 582.7 590.2 598.6 604.3 26017.1 38452.0 39805.0 39935.6 39971.4 39589.6 39896.2 39975.0 39988.6 40030.6 7800.6 7939.0 7943.2 7950.4 7950.6 7540.4 10023.5 10321.7 10322.1 10676.1 10325.2 10414.1 10421.7 10426.3 10428.2 10266.5 10267.6 10321.5 10339.9 10349.4 9860.0 10085.7 10089.0 10089.0 10095.4 36726.8 36786.4 37037.0 37100.6 37132.4 2893.6 3060.9 3094.6 3147.7 3198.3 28785.1 28859.9 29027.4 29104.4 29134.4 3225.7 3248.7 3301.8 3318.4 3333.4 202946.0 261837.7 262067.0 262124.0 262333.0 54627.5 55300.4 55301.4 55348.7 55364.4 32863.3 33467.5 33640.0 35441.3 35442.6 15639.0 15791.8 15797.8 15821.2 15823.2 10961.3 11664.7 11678.7 11760.9 11769.7 17565.0 18220.3 18314.3 18316.6 18486.0 6838.9 6967.4 6980.3 7058.2 7138.4 775.0 840.7 860.2 860.5 905.3 24197.2 25912.2 26071.5 26102.9 26417.1 954.5 971.9 986.3 1026.0 1072.8 13445.4 14151.9 14212.5 14295.1 14389.6 371302.0 378529.0 378961.0 379683.0 380813.0 49316.8 49764.8 49769.0 49780.3 49919.5 1100.4 1113.6 1157.1 1176.6 1219.3 26156.7 28977.4 29199.6 29229.0 30090.7 41797.8 42371.8 42385.4 42389.4 42402.4 294215.0 296750.0 296787.0 297413.0 297930.0 24890.0 25493.7 25523.0 25597.5 26743.5 41137.8 41268.8 41666.6 42082.6 42564.4 35870.1 35990.5 36057.5 36737.4 36760.1 35150.8 35472.8 36102.8 36449.0 36540.8 35302.3 35318.6 35320.0 35745.1 35796.6 31209.8 32558.0 32572.7 32635.0 32718.2 25110.5 25217.9 25273.4 25433.4 25476.0 08:55:11 INFO - PROCESS | 10277 | 08:55:11 INFO - PROCESS | 10277 | [#2] jquery.html Cycles:180 Average:24678.43 Median:4497.86 stddev:65753.16 (1461.9%) stddev-sans-first:65912.24 08:55:11 INFO - PROCESS | 10277 | Values: 348.7 363.9 369.9 371.0 388.7 12636.7 16423.7 16571.1 16648.6 17449.0 16439.2 16958.4 17549.0 17615.0 17692.4 5079.7 5084.3 5204.2 5209.3 5257.6 3766.2 5261.4 5347.4 5899.1 6214.6 6237.8 6290.6 6308.7 6309.9 6316.9 5965.2 6202.7 6237.3 6249.3 6293.6 4839.1 5457.2 5466.7 5468.8 5471.3 11175.2 11625.4 11679.7 11768.3 11796.5 1754.5 1799.9 1889.3 1897.4 1932.4 9015.9 9182.8 9313.9 9447.7 9858.8 1699.9 1777.1 1794.2 1794.3 1807.3 70470.0 72194.0 72673.6 73031.3 73116.0 10075.6 10101.5 10128.5 10440.3 10467.4 14006.0 14013.1 14019.8 14028.6 14052.0 7309.7 7531.6 7602.5 7727.6 7738.8 7302.5 7312.6 7495.7 7501.3 7535.4 4313.8 4396.4 4404.5 4488.6 4507.1 1843.5 1853.7 1857.0 1874.1 1904.2 687.6 689.7 747.5 793.8 845.2 16915.4 17361.7 17510.3 17684.0 17944.6 793.4 863.6 886.9 905.3 906.7 9467.7 9639.3 9722.7 9999.1 10196.4 393968.0 395357.0 398749.0 399729.0 399957.0 72590.0 78857.0 79424.6 80417.6 81084.0 906.0 921.1 943.7 944.9 947.5 16377.2 16569.5 17026.5 17153.7 17297.0 38530.2 38585.2 38591.0 39170.0 39547.4 53432.5 53900.2 54687.6 55784.7 56037.0 6652.7 7514.8 7716.3 7860.6 7896.5 9008.5 11978.6 12212.6 12424.8 12585.7 9734.7 9875.3 10090.2 10508.9 10549.6 9925.9 10398.8 10420.4 10434.9 10461.8 10108.9 10250.8 10275.9 10344.9 10555.2 7380.6 7520.8 7740.7 7790.9 7901.7 9373.0 10103.0 10204.7 10275.4 10399.8 08:55:11 INFO - PROCESS | 10277 | 08:55:11 INFO - PROCESS | 10277 | [#3] mootools.html Cycles:180 Average:5171.52 Median:5307.27 stddev:2936.46 (55.3%) stddev-sans-first:2930.97 08:55:11 INFO - PROCESS | 10277 | Values: 1392.9 1437.0 1491.7 1672.0 1699.1 7595.2 8072.7 8075.6 8084.8 8087.2 6883.8 7077.0 7715.5 7912.7 7923.4 2147.2 2170.2 2175.1 2179.3 2179.5 2027.5 2068.8 2094.7 2096.6 2097.2 1821.7 2062.7 2138.3 2138.8 2142.9 2122.6 2137.7 2143.0 2146.9 2158.2 2183.2 2207.0 2207.9 2208.3 2211.0 7825.8 7873.4 7876.1 7880.7 7887.6 4550.7 4687.5 4694.4 4696.5 4700.9 2718.3 2902.1 2903.1 2911.2 2916.4 853.4 894.7 904.5 912.4 914.8 10550.1 10813.7 10822.1 10842.4 10844.6 4027.9 4120.9 4259.0 4262.4 4266.5 9273.6 9312.8 9320.1 9327.4 9337.4 4708.4 4712.1 4713.9 4716.8 4717.3 4038.5 4180.6 4215.2 4221.2 4227.4 3512.6 3578.6 3631.4 3637.5 3694.6 1082.5 1096.1 1096.8 1101.6 1118.5 589.4 653.9 750.7 782.1 791.0 5160.3 5278.7 5337.0 5366.8 5475.1 850.7 861.6 885.3 887.6 893.2 3452.2 3514.3 3520.2 3556.2 3614.9 9172.0 9629.1 9695.0 9700.7 9711.7 9468.6 9783.5 9821.6 9845.0 9876.1 7178.8 7292.5 7307.9 7311.5 7368.8 4959.0 4967.0 5030.7 5276.6 5335.8 8840.3 9014.1 9082.9 9144.3 9210.0 8817.9 9106.1 9173.7 9213.5 9246.5 7247.7 7452.5 7642.5 7644.4 7647.5 7552.3 7555.3 7560.5 7563.2 7631.9 6671.4 6679.7 6773.2 6787.7 6882.3 6647.3 6688.5 6734.7 6790.9 6885.8 6001.7 6149.8 6162.9 6173.4 6187.4 4516.5 4574.5 4612.1 4617.0 4734.6 4550.7 4576.0 4600.7 4602.5 4698.8 08:55:11 INFO - PROCESS | 10277 | 08:55:11 INFO - PROCESS | 10277 | [#4] prototype.html Cycles:180 Average:4208.71 Median:4859.28 stddev:1228.43 (25.3%) stddev-sans-first:1196.20 08:55:11 INFO - PROCESS | 10277 | Values: 292.9 297.1 301.6 302.6 305.1 4900.8 4905.6 4932.5 4938.6 4951.4 4814.7 4827.9 4886.3 4897.2 4897.6 3547.8 3675.5 3677.8 3814.2 3835.7 3804.8 3810.6 3814.9 3840.2 3847.6 3766.6 3771.1 3782.8 3787.4 3806.7 3481.8 3522.2 3653.7 3664.2 3779.0 3322.2 3326.6 3346.8 3362.4 3372.2 4652.9 4667.8 4678.5 4702.3 4720.2 4236.7 4353.0 4358.7 4360.1 4366.5 4986.5 4997.1 5019.3 5053.4 5080.2 3652.3 3665.9 3680.4 3681.1 3686.4 5142.6 5311.2 5349.6 5355.9 5356.8 3670.7 3671.8 3685.8 3708.3 3711.8 3739.0 3741.9 3756.8 3768.5 3782.8 4268.7 4269.4 4282.6 4287.4 4310.2 4859.3 5006.1 5022.9 5030.3 5046.6 1292.9 1314.2 1321.0 1323.8 1325.1 816.9 850.6 856.0 872.7 879.9 3978.6 3986.5 4238.9 4364.2 4400.4 5197.9 5206.0 5206.3 5208.4 5210.7 4450.9 4451.9 4461.4 4494.2 4494.6 2594.5 2737.8 2753.7 2758.4 2758.4 4859.3 4870.2 4896.5 4905.7 4906.8 5334.7 5340.3 5350.1 5364.2 5371.5 4677.5 4876.7 4897.4 4937.0 4943.8 5247.2 5268.9 5270.5 5273.6 5292.0 5117.4 5194.7 5196.9 5197.5 5216.7 4695.5 4888.3 4908.2 4912.7 4914.9 3680.2 3704.4 3706.6 3715.9 3731.6 5290.5 5320.8 5320.9 5328.2 5331.5 4960.9 5048.3 5129.8 5138.6 5140.1 5052.1 5074.2 5079.6 5088.5 5100.2 4995.3 5001.1 5028.3 5056.2 5059.9 4871.7 4889.8 5104.8 5117.6 5124.4 4837.0 4981.3 5000.1 5009.2 5011.7 08:55:11 INFO - PROCESS | 10277 | 08:55:11 INFO - PROCESS | 10277 | [#5] yui.html Cycles:180 Average:16983.75 Median:574.19 stddev:23918.68 (4165.6%) stddev-sans-first:23954.33 08:55:11 INFO - PROCESS | 10277 | Values: 650.0 675.6 705.4 731.0 746.7 11800.8 12458.5 12522.6 12538.5 12540.4 13390.4 13505.3 13533.2 13539.3 13622.0 621.0 745.4 759.3 770.4 771.9 766.7 769.0 773.1 776.6 779.8 816.6 819.3 819.7 819.9 819.9 639.1 658.7 663.9 668.8 809.4 579.8 588.5 592.2 593.3 594.3 12977.8 13063.4 13068.2 13073.3 13107.5 11576.5 11790.5 12060.2 12084.8 12539.9 9975.4 10167.0 11409.1 11457.3 11496.1 3972.5 4031.0 4115.0 4192.8 4212.9 49265.3 51599.2 61502.0 61663.0 62096.4 10110.7 10359.1 10476.9 10510.5 10691.2 18321.7 18376.3 18393.2 18395.1 18395.3 6870.6 6887.0 7051.5 7105.9 7169.9 3520.7 3586.4 3611.9 3612.5 3686.0 2867.0 2949.9 2955.8 2960.2 2961.4 495.1 509.4 512.1 515.1 519.0 519.9 521.8 577.9 583.6 599.0 7771.2 7905.6 7935.9 8211.6 8269.5 479.6 570.5 595.9 609.7 611.8 3721.1 3802.2 3837.2 3882.4 3961.1 53984.0 79109.2 89277.0 98719.0 99354.5 80740.0 81305.6 81345.2 82648.6 84356.6 72293.0 72626.6 73153.6 74530.0 74578.0 7822.8 8014.0 8042.6 8194.4 8225.2 33543.5 39245.4 41006.4 44828.3 47153.0 63219.7 63287.0 63479.7 63483.0 65920.0 9936.4 10432.3 10797.5 10895.1 10911.0 12866.7 12928.5 13156.1 13278.4 13281.6 10885.8 10926.4 11371.1 11921.0 11967.0 9582.4 9658.9 9735.3 9755.3 9828.4 11543.4 11637.9 11942.5 12358.8 12439.7 8785.6 8792.0 9051.4 9995.3 10057.7 8657.1 8982.2 9409.1 9446.6 9557.3 08:55:11 INFO - PROCESS | 10277 | -------- Summary: end -------- 08:55:11 INFO - PROCESS | 10277 | 08:55:12 INFO - TEST-INFO | 10277: exit 0 08:55:12 INFO - TEST-OK | dromaeo_css | took 1120754ms 08:55:12 INFO - TEST-START | kraken 08:55:12 INFO - operating with platform_type : linux_ 08:55:12 INFO - Initialising browser for kraken test... 08:55:12 INFO - TEST-INFO | started process 10468 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvNysEF/profile http://localhost:33253/getInfo.html) 08:55:16 INFO - PROCESS | 10468 | JavaScript error: , line 0: uncaught exception: undefined 08:55:16 INFO - PROCESS | 10468 | __metrics Screen width/height:1600/1200 08:55:16 INFO - PROCESS | 10468 | colorDepth:24 08:55:16 INFO - PROCESS | 10468 | Browser inner width/height: 1024/697 08:55:16 INFO - PROCESS | 10468 | __metrics 08:55:17 INFO - PROCESS | 10468 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:55:17 INFO - PROCESS | 10468 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:55:18 INFO - TEST-INFO | 10468: exit 0 08:55:18 INFO - Browser initialized. 08:55:18 INFO - Running cycle 1/1 for kraken test... 08:55:18 INFO - TEST-INFO | started process 10548 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvNysEF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:55:30 INFO - PROCESS | 10548 | RSS: Main: 158650368 08:55:30 INFO - PROCESS | 10548 | 08:55:33 INFO - PROCESS | 10548 | Cycle 1(1): loaded http://localhost:33253/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33253/tests/kraken/driver.html?testName=audio-beat-detection) 08:55:34 INFO - PROCESS | 10548 | RSS: Main: 215232512 08:55:34 INFO - PROCESS | 10548 | 08:55:37 INFO - PROCESS | 10548 | Cycle 1(1): loaded http://localhost:33253/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33253/tests/kraken/driver.html?testName=audio-dft) 08:55:37 INFO - PROCESS | 10548 | RSS: Main: 193777664 08:55:37 INFO - PROCESS | 10548 | 08:55:41 INFO - PROCESS | 10548 | Cycle 1(1): loaded http://localhost:33253/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33253/tests/kraken/driver.html?testName=audio-fft) 08:55:41 INFO - PROCESS | 10548 | RSS: Main: 274288640 08:55:41 INFO - PROCESS | 10548 | 08:55:44 INFO - PROCESS | 10548 | Cycle 1(1): loaded http://localhost:33253/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33253/tests/kraken/driver.html?testName=audio-oscillator) 08:55:44 INFO - PROCESS | 10548 | RSS: Main: 182652928 08:55:44 INFO - PROCESS | 10548 | 08:55:46 INFO - PROCESS | 10548 | Cycle 1(1): loaded http://localhost:33253/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33253/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:55:47 INFO - PROCESS | 10548 | RSS: Main: 187097088 08:55:47 INFO - PROCESS | 10548 | 08:55:50 INFO - PROCESS | 10548 | Cycle 1(1): loaded http://localhost:33253/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33253/tests/kraken/driver.html?testName=imaging-darkroom) 08:55:51 INFO - PROCESS | 10548 | RSS: Main: 223440896 08:55:51 INFO - PROCESS | 10548 | 08:55:54 INFO - PROCESS | 10548 | Cycle 1(1): loaded http://localhost:33253/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33253/tests/kraken/driver.html?testName=imaging-desaturate) 08:55:55 INFO - PROCESS | 10548 | RSS: Main: 216510464 08:55:55 INFO - PROCESS | 10548 | 08:55:58 INFO - PROCESS | 10548 | Cycle 1(1): loaded http://localhost:33253/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33253/tests/kraken/driver.html?testName=json-parse-financial) 08:55:58 INFO - PROCESS | 10548 | RSS: Main: 219885568 08:55:58 INFO - PROCESS | 10548 | 08:56:00 INFO - PROCESS | 10548 | Cycle 1(1): loaded http://localhost:33253/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33253/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:56:01 INFO - PROCESS | 10548 | RSS: Main: 185765888 08:56:01 INFO - PROCESS | 10548 | 08:56:02 INFO - PROCESS | 10548 | Cycle 1(1): loaded http://localhost:33253/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33253/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:56:03 INFO - PROCESS | 10548 | RSS: Main: 191213568 08:56:03 INFO - PROCESS | 10548 | 08:56:05 INFO - PROCESS | 10548 | Cycle 1(1): loaded http://localhost:33253/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33253/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:56:06 INFO - PROCESS | 10548 | RSS: Main: 195956736 08:56:06 INFO - PROCESS | 10548 | 08:56:09 INFO - PROCESS | 10548 | Cycle 1(1): loaded http://localhost:33253/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33253/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:56:09 INFO - PROCESS | 10548 | RSS: Main: 190509056 08:56:09 INFO - PROCESS | 10548 | 08:56:12 INFO - PROCESS | 10548 | Cycle 1(1): loaded http://localhost:33253/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33253/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:56:13 INFO - PROCESS | 10548 | RSS: Main: 194142208 08:56:13 INFO - PROCESS | 10548 | 08:56:15 INFO - PROCESS | 10548 | Cycle 1(1): loaded http://localhost:33253/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33253/tests/kraken/driver.html?testName=ai-astar) 08:56:15 INFO - PROCESS | 10548 | RSS: Main: 244682752 08:56:15 INFO - PROCESS | 10548 | 08:56:15 INFO - PROCESS | 10548 | __start_tp_report 08:56:15 INFO - PROCESS | 10548 | _x_x_mozilla_page_load 08:56:15 INFO - PROCESS | 10548 | _x_x_mozilla_page_load_details 08:56:15 INFO - PROCESS | 10548 | |i|pagename|runs| 08:56:15 INFO - PROCESS | 10548 | |0;ai-astar;105;114;115;115;114;115;113;113;113;114 08:56:15 INFO - PROCESS | 10548 | |1;audio-beat-detection;150;122;127;186;123;123;152;123;169;121 08:56:15 INFO - PROCESS | 10548 | |2;audio-dft;160;162;160;161;162;161;161;164;164;163 08:56:15 INFO - PROCESS | 10548 | |3;audio-fft;75;76;76;129;75;76;74;75;101;76 08:56:15 INFO - PROCESS | 10548 | |4;audio-oscillator;86;86;118;85;86;87;112;85;86;131 08:56:15 INFO - PROCESS | 10548 | |5;imaging-gaussian-blur;116;117;116;117;117;117;117;117;117;117 08:56:15 INFO - PROCESS | 10548 | |6;imaging-darkroom;147;147;146;147;146;146;146;146;145;146 08:56:15 INFO - PROCESS | 10548 | |7;imaging-desaturate;95;95;95;95;94;95;95;95;95;94 08:56:15 INFO - PROCESS | 10548 | |8;json-parse-financial;62;64;63;63;65;63;63;63;63;63 08:56:15 INFO - PROCESS | 10548 | |9;json-stringify-tinderbox;65;66;66;67;67;66;66;67;66;65 08:56:15 INFO - PROCESS | 10548 | |10;stanford-crypto-aes;80;80;78;82;85;79;78;79;78;78 08:56:15 INFO - PROCESS | 10548 | |11;stanford-crypto-ccm;147;129;129;130;129;129;128;129;180;143 08:56:15 INFO - PROCESS | 10548 | |12;stanford-crypto-pbkdf2;162;169;162;163;162;163;161;162;164;161 08:56:15 INFO - PROCESS | 10548 | |13;stanford-crypto-sha256-iterative;67;68;66;66;68;66;66;65;67;66 08:56:15 INFO - PROCESS | 10548 | __end_tp_report 08:56:15 INFO - PROCESS | 10548 | __start_cc_report 08:56:15 INFO - PROCESS | 10548 | _x_x_mozilla_cycle_collect,1918 08:56:15 INFO - PROCESS | 10548 | __end_cc_report 08:56:15 INFO - PROCESS | 10548 | __startTimestamp1469202975273__endTimestamp 08:56:15 INFO - PROCESS | 10548 | 08:56:15 INFO - PROCESS | 10548 | ------- Summary: start ------- 08:56:15 INFO - PROCESS | 10548 | Number of tests: 14 08:56:15 INFO - PROCESS | 10548 | 08:56:15 INFO - PROCESS | 10548 | [#0] ai-astar Cycles:10 Average:113.10 Median:114.00 stddev:2.96 (2.6%) stddev-sans-first:0.87 08:56:15 INFO - PROCESS | 10548 | Values: 105.0 114.0 115.0 115.0 114.0 115.0 113.0 113.0 113.0 114.0 08:56:15 INFO - PROCESS | 10548 | 08:56:15 INFO - PROCESS | 10548 | [#1] audio-beat-detection Cycles:10 Average:139.60 Median:138.50 stddev:23.38 (16.9%) stddev-sans-first:24.50 08:56:15 INFO - PROCESS | 10548 | Values: 150.0 122.0 127.0 186.0 123.0 123.0 152.0 123.0 169.0 121.0 08:56:15 INFO - PROCESS | 10548 | 08:56:15 INFO - PROCESS | 10548 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.48 (0.9%) stddev-sans-first:1.41 08:56:15 INFO - PROCESS | 10548 | Values: 160.0 162.0 160.0 161.0 162.0 161.0 161.0 164.0 164.0 163.0 08:56:15 INFO - PROCESS | 10548 | 08:56:15 INFO - PROCESS | 10548 | [#3] audio-fft Cycles:10 Average:83.30 Median:75.50 stddev:17.98 (23.8%) stddev-sans-first:18.81 08:56:15 INFO - PROCESS | 10548 | Values: 75.0 76.0 76.0 129.0 75.0 76.0 74.0 75.0 101.0 76.0 08:56:15 INFO - PROCESS | 10548 | 08:56:15 INFO - PROCESS | 10548 | [#4] audio-oscillator Cycles:10 Average:96.20 Median:86.00 stddev:17.28 (20.1%) stddev-sans-first:17.93 08:56:15 INFO - PROCESS | 10548 | Values: 86.0 86.0 118.0 85.0 86.0 87.0 112.0 85.0 86.0 131.0 08:56:15 INFO - PROCESS | 10548 | 08:56:15 INFO - PROCESS | 10548 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 08:56:15 INFO - PROCESS | 10548 | Values: 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 08:56:15 INFO - PROCESS | 10548 | 08:56:15 INFO - PROCESS | 10548 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 08:56:15 INFO - PROCESS | 10548 | Values: 147.0 147.0 146.0 147.0 146.0 146.0 146.0 146.0 145.0 146.0 08:56:15 INFO - PROCESS | 10548 | 08:56:15 INFO - PROCESS | 10548 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:56:15 INFO - PROCESS | 10548 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 94.0 08:56:15 INFO - PROCESS | 10548 | 08:56:15 INFO - PROCESS | 10548 | [#8] json-parse-financial Cycles:10 Average:63.20 Median:63.00 stddev:0.79 (1.3%) stddev-sans-first:0.71 08:56:15 INFO - PROCESS | 10548 | Values: 62.0 64.0 63.0 63.0 65.0 63.0 63.0 63.0 63.0 63.0 08:56:15 INFO - PROCESS | 10548 | 08:56:15 INFO - PROCESS | 10548 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.00 stddev:0.74 (1.1%) stddev-sans-first:0.67 08:56:15 INFO - PROCESS | 10548 | Values: 65.0 66.0 66.0 67.0 67.0 66.0 66.0 67.0 66.0 65.0 08:56:15 INFO - PROCESS | 10548 | 08:56:15 INFO - PROCESS | 10548 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:79.50 stddev:2.26 (2.8%) stddev-sans-first:2.40 08:56:15 INFO - PROCESS | 10548 | Values: 80.0 80.0 78.0 82.0 85.0 79.0 78.0 79.0 78.0 78.0 08:56:15 INFO - PROCESS | 10548 | 08:56:15 INFO - PROCESS | 10548 | [#11] stanford-crypto-ccm Cycles:10 Average:137.30 Median:129.50 stddev:16.45 (12.7%) stddev-sans-first:17.06 08:56:15 INFO - PROCESS | 10548 | Values: 147.0 129.0 129.0 130.0 129.0 129.0 128.0 129.0 180.0 143.0 08:56:15 INFO - PROCESS | 10548 | 08:56:15 INFO - PROCESS | 10548 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.90 Median:162.50 stddev:2.33 (1.4%) stddev-sans-first:2.45 08:56:15 INFO - PROCESS | 10548 | Values: 162.0 169.0 162.0 163.0 162.0 163.0 161.0 162.0 164.0 161.0 08:56:15 INFO - PROCESS | 10548 | 08:56:15 INFO - PROCESS | 10548 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:66.50 stddev:0.97 (1.5%) stddev-sans-first:1.01 08:56:15 INFO - PROCESS | 10548 | Values: 67.0 68.0 66.0 66.0 68.0 66.0 66.0 65.0 67.0 66.0 08:56:15 INFO - PROCESS | 10548 | -------- Summary: end -------- 08:56:15 INFO - PROCESS | 10548 | 08:56:16 INFO - TEST-INFO | 10548: exit 0 08:56:16 INFO - TEST-OK | kraken | took 63951ms 08:56:16 INFO - SUITE-END | took 1184s 08:56:16 INFO - Completed test suite (00:19:44) 08:56:16 INFO - javascript benchmark 08:56:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2576.0597381955586, 2579.5614745493262, 2614.973850261497, 2622.881970311336, 2625.5405304071783, 4583.335416364625, 4642.094791515648, 4679.672422930396, 4699.90600187996, 4702.835400760974, 4671.39271894654, 4690.835820746274, 4716.292556116584, 4742.6205903527725, 4759.857204283869, 4311.094670119279, 4360.956390436103, 4363.978180109095, 4377.255866502702, 4394.824207031715, 4332.1335732853395, 4404.845830395937, 4448.488423831269, 4464.5981861632445, 4485.327200919855, 4420.3369494575745, 4437.955620443787, 4477.977610111945, 4486.327050942368, 4493.41585593874, 4198.916021679549, 4253.489581250239, 4264.0, 4378.8029538670835, 4384.408104905829, 4251.3622956556455, 4268.445102136733, 4305.590968857985, 4312.935305970413, 4373.343998400265, 4652.976735116336, 4700.271457924027, 4722.362481065081, 4744.454387745419, 4767.856964291077, 5085.491450854922, 5089.083964886319, 5092.2361645753435, 5093.847184584469, 5103.336566246401, 4924.852254432372, 4996.0, 5031.195008798574, 5079.4412614612365, 5139.691618502902, 4766.404199475066, 4772.427308722976, 4781.545753153445, 4787.808487660524, 4797.088553174885, 5256.710880901511, 5259.47405259471, 5264.52619264268, 5267.157254839208, 5270.78916843322, 4774.4509381421585, 4895.31465594817, 4963.8014479421145, 4967.05625931072, 4999.42506611737, 5060.114479966065, 5060.898782024413, 5099.694018358836, 5103.489651034941, 5107.923381149286, 5006.224035274538, 5006.4743201964, 5011.924821127686, 5013.0, 5055.69665820052, 4783.7129772213775, 4837.05677392905, 4844.539768721966, 4869.829555965524, 4870.878228044327, 4204.348326009474, 4223.915521689549, 4250.404943307939, 4260.701750877409, 4317.244482215662, 3716.3496388132507, 3719.8326075326677, 3722.1253005543676, 3754.9436758448646, 3762.435634654824, 4344.4352234209355, 4359.869203923888, 4363.869083927487, 4405.229084910128, 4406.030673251879, 4883.755812209375, 4987.850364489072, 5033.5469807716745, 5061.544460998528, 5093.18509038552, 4322.589354011427, 4322.740635561876, 4360.585744354345, 4367.71609845359, 4413.271810151353, 4508.639308855284, 4512.9097418052115, 4515.571020753023, 4555.407796986437, 4578.5421457853945, 4616.146012987608, 4623.88440288982, 4658.464276608233, 4739.763011849463, 4744.739039352799, 4999.175136102648, 5006.173981293192, 5007.198848184273, 5046.066477701637, 5050.924236136388, 4647.883802904955, 4682.461516925598, 4682.601978831701, 4683.063387322617, 4727.030958653399, 4840.7337596432535, 4876.024795040935, 4883.87790305231, 4918.458969513422, 4973.875653108556, 5015.874603134951, 5020.949790502048, 5038.647294689336, 5044.117279476003, 5084.313617661568, 4908.11653902301, 4916.582090522203, 4922.827701030446, 4923.753812309442, 4970.62720295972, 4778.33103365536, 4850.296706977398, 4888.266759985889, 4917.1149193145575, 4971.304017437489, 4830.961343311205, 4831.057943701085, 4844.515548445268, 4845.927311090266, 4852.73309967941, 4910.975445122752, 4938.111139994836, 4947.406311242674, 4947.752612369439, 4954.3311652926395, 4679.344891715231, 4721.622270218306, 4786.664933454625, 4833.32333473307, 4866.8053277868485], "value": 4621.55845188225, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.3490913251588, 582.7202942587555, 590.1619700025963, 598.6408155106936, 604.3141034925361, 26017.089401870915, 38452.0, 39805.0, 39935.60064399355, 39971.400428993555, 39589.604103958955, 39896.20207595846, 39975.0, 39988.60011399885, 40030.59969400305, 7800.648970796314, 7939.047314322261, 7943.165967573408, 7950.403719721044, 7950.602469876512, 7540.434467414966, 10023.498825058754, 10321.741956451073, 10322.122619577307, 10676.092532134779, 10325.225608079387, 10414.11480024195, 10421.69728783902, 10426.322289051188, 10428.16574674028, 10266.538005789758, 10267.589296428208, 10321.483925803679, 10339.896601033968, 10349.379037257788, 9859.950700246525, 10085.747856303578, 10089.0, 10089.0, 10095.444750538718, 36726.81636591827, 36786.448203276974, 37037.0, 37100.628993710256, 37132.44301335482, 2893.56596510523, 3060.853995175445, 3094.582231398755, 3147.685231476857, 3198.3123628420003, 28785.136445906657, 28859.85570072157, 29027.419451611062, 29104.41791164186, 29134.41731165386, 3225.709686128236, 3248.658890816454, 3301.8018918864946, 3318.369509793132, 3333.383324085052, 202946.0, 261837.69081154664, 262067.0, 262124.0, 262333.0, 54627.453725463034, 55300.446995530336, 55301.44698552963, 55348.72325638346, 55364.44635553673, 32863.342733145204, 33467.49798753021, 33640.0, 35441.34189935765, 35442.64557354445, 15639.0, 15791.763123553155, 15797.763033554505, 15821.208939552977, 15823.208839558207, 10961.287516311415, 11664.6500604982, 11678.70803229926, 11760.94119529414, 11769.705757356134, 17565.0, 18220.271189152285, 18314.26742930268, 18316.63366732658, 18486.0, 6838.855915774436, 6967.407770339578, 6980.289828991929, 7058.153021637437, 7138.357547820721, 775.0389516998881, 840.6553313141704, 860.2129051917425, 860.5095095795336, 905.2848249882519, 24197.15309964143, 25912.22263332103, 26071.478570428484, 26102.86948565245, 26417.07540236121, 954.5084281594984, 971.8764499568324, 986.2800155886243, 1025.9692209233735, 1072.8176210044312, 13445.394957226948, 14151.929240353733, 14212.502562410265, 14295.142291462545, 14389.568312950629, 371302.0, 378529.0, 378961.0, 379683.0, 380813.0, 49316.75341623269, 49764.75117624461, 49769.0, 49780.253296200586, 49919.50080499148, 1100.4167791070745, 1113.5935383584933, 1157.1379322404862, 1176.564671071709, 1219.2806244315896, 26156.73843261543, 28977.42045159127, 29199.562006569493, 29229.01261960222, 30090.69909300879, 41797.79101104475, 42371.78814106033, 42385.36421953735, 42389.36415953825, 42402.36396453994, 294215.0, 296750.0, 296787.0, 297413.0, 297930.0, 24890.0, 25493.74506254988, 25523.0, 25597.488050238517, 26743.465130696888, 41137.79431102825, 41268.79365603153, 41666.58333416627, 42082.579174207865, 42564.36153457639, 35870.10324741902, 35990.46014309735, 36057.45913811243, 36737.448938265414, 36760.08099797527, 35150.824245878604, 35472.82263588665, 36102.8194859024, 36449.0, 36540.81729591335, 35302.29395412129, 35318.64681353256, 35320.0, 35745.1063723409, 35796.64203357933, 31209.84395078101, 32558.0, 32572.67427325791, 32635.0, 32718.182045449055, 25110.49779004373, 25217.87391063033, 25273.368165796, 25433.364165896, 25476.0], "value": 17693.405421454197, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.6861824358079, 363.9363111455496, 369.8742427574624, 370.9666130048296, 388.6812813492935, 12636.68408289792, 16423.671526569462, 16571.08859012754, 16648.583785405357, 17449.04030278334, 16439.178041097955, 16958.40645577405, 17549.0, 17615.0, 17692.38076667317, 5079.720615366154, 5084.339035925324, 5204.193350030732, 5209.32278803755, 5257.553107985826, 3766.152615661482, 5261.39493958194, 5347.411784703699, 5899.144624029514, 6214.564980451348, 6237.812865614039, 6290.622562646233, 6308.684565771693, 6309.9369006310035, 6316.905246421307, 5965.164876917235, 6202.658853763041, 6237.313895471494, 6249.312575616678, 6293.559450838443, 4839.104765618372, 5457.2359869618285, 5466.699331536764, 5468.7539060741965, 5471.261379713767, 11175.21773475857, 11625.418729063598, 11679.7080072998, 11768.293902365886, 11796.528138874435, 1754.5175076853968, 1799.874008819383, 1889.3009586452963, 1897.4212865076147, 1932.3623204342534, 9015.909840901573, 9182.816343673156, 9313.860292095624, 9447.716568502956, 9858.80282394348, 1699.8555122814575, 1777.111444277861, 1794.246416505071, 1794.2733193056833, 1807.295154889581, 70470.0, 72194.0, 72673.63663181651, 73031.26968730298, 73116.0, 10075.647352342632, 10101.494925253708, 10128.54421551032, 10440.269181157399, 10467.424291664032, 14006.0, 14013.089149205269, 14019.789703154462, 14028.579142625738, 14052.0, 7309.744158954411, 7531.623418829036, 7602.46782725204, 7727.5749833758555, 7738.806529836686, 7302.525335853153, 7312.561246325237, 7495.66269517873, 7501.324880760649, 7535.359494442924, 4313.827446902152, 4396.4064851244675, 4404.537523560044, 4488.573585509372, 4507.143642707875, 1843.5298998755231, 1853.6570734413906, 1856.950822785149, 1874.0816999670335, 1904.1716853168916, 687.5737043033251, 689.6757628231874, 747.4618274842105, 793.765839077462, 845.159066728609, 16915.407960721317, 17361.65276694459, 17510.29958801659, 17684.0, 17944.641107177784, 793.4445887878508, 863.6113748813059, 886.9467831930104, 905.3345790843724, 906.6781292641017, 9467.66863159786, 9639.277054220962, 9722.659706910366, 9999.100080992746, 10196.4391958443, 393968.0, 395357.02321488207, 398749.0, 399729.0, 399957.0, 72590.0, 78857.02857428495, 79424.60287698524, 80417.59791201123, 81084.0, 905.9954700226325, 921.1157289002632, 943.7451887990342, 944.8724422203052, 947.4552132523827, 16377.181140943143, 16569.502914912573, 17026.489205323862, 17153.74269385985, 17297.0, 38530.22939541138, 38585.237738247095, 38591.0, 39170.0, 39547.4294170878, 53432.46567534275, 53900.19149712679, 54687.63280918009, 55784.72107639436, 56037.0, 6652.667366631552, 7514.774556763306, 7716.344110750649, 7860.567668778043, 7896.526208427513, 9008.504532250789, 11978.58074967372, 12212.633620991384, 12424.813627795771, 12585.685357866127, 9734.659286924923, 9875.308728388944, 10090.19278457707, 10508.947455262674, 10549.630762923261, 9925.900740992498, 10398.792024159324, 10420.374777513374, 10434.895651043393, 10461.790764184521, 10108.949455252676, 10250.794984100126, 10275.897241027793, 10344.896551034393, 10555.208359373231, 7380.557166570023, 7520.811979700551, 7740.651670674721, 7790.922090779246, 7901.68393264263, 9373.0, 10103.0, 10204.744881378025, 10275.383476991405, 10399.792004159723], "value": 8220.339713532594, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1392.937317820698, 1437.0156442836658, 1491.7314883320998, 1671.9582010449744, 1699.1249506504153, 7595.240475952409, 8072.677092916284, 8075.596220188996, 8084.7978800529945, 8087.150849160842, 6883.759068432606, 7076.964615176929, 7715.498492597977, 7912.723054693087, 7923.445358824884, 2147.1518750093705, 2170.1861801824316, 2175.0755928730305, 2179.3135162423864, 2179.4660308224506, 2027.543802644408, 2068.7620923593754, 2094.685797130435, 2096.5911647228795, 2097.1820989813987, 1821.6720990221754, 2062.7009083682856, 2138.3264271754424, 2138.77542858, 2142.9035693393835, 2122.5754849030177, 2137.7434707835005, 2143.0, 2146.9355919322447, 2158.2338269914267, 2183.159483598826, 2207.0399376271375, 2207.9006444709867, 2208.3374987503844, 2211.0381983836924, 7825.804354891174, 7873.370130389555, 7876.133625301212, 7880.684772609089, 7887.645055972495, 4550.68145229834, 4687.484376718558, 4694.436667599875, 4696.483386827446, 4700.929486057712, 2718.3418114949864, 2902.1438675590753, 2903.0855280586547, 2911.199420159452, 2916.402137561795, 853.3599800149888, 894.7002754077392, 904.4754042655244, 912.3704643795826, 914.7758799094198, 10550.050495455369, 10813.729656758487, 10822.134229261641, 10842.403667798268, 10844.566217351297, 4027.8993025174605, 4120.938185927213, 4259.0204253021975, 4262.42457268271, 4266.530681625019, 9273.58268877902, 9312.813743725223, 9320.067993200626, 9327.393719408217, 9337.439753614804, 4708.411448568929, 4712.128256272601, 4713.905721885543, 4716.787744551503, 4717.315989181549, 4038.495188101487, 4180.581941805795, 4215.220184265921, 4221.197972385237, 4227.387028880795, 3512.5784905811465, 3578.570571531433, 3631.4008188649104, 3637.5089362936196, 3694.556653201633, 1082.5020490574425, 1096.0628662493612, 1096.819024860905, 1101.6474728086935, 1118.5134466507095, 589.3634874335793, 653.9346065393518, 750.6847124207845, 782.1357400072951, 790.9841803163904, 5160.303359046556, 5278.736063196825, 5336.973315133399, 5366.812161574404, 5475.123980163155, 850.6639877248576, 861.5993562993239, 885.2784980241083, 887.6050157679899, 893.1648908270788, 3452.171478845059, 3514.279572687593, 3520.207953210507, 3556.2354093869944, 3614.8734794282072, 9171.954140229256, 9629.133377995873, 9695.03049695039, 9700.660476883417, 9711.708648740549, 9468.57391417388, 9783.46190959504, 9821.607135714634, 9845.0, 9876.111149996535, 7178.784636460915, 7292.489525733254, 7307.853842923112, 7311.488195826241, 7368.815779605553, 4959.0, 4966.975165124151, 5030.6730062547285, 5276.551493123127, 5335.813246536352, 8840.292776577988, 9014.143656352637, 9082.909170908471, 9144.314176436661, 9210.0, 8817.867731983897, 9106.134917182857, 9173.724788256362, 9213.539323033956, 9246.4914429707, 7247.746328878464, 7452.478326517092, 7642.5032372895585, 7644.426667999811, 7647.541147531166, 7552.320291173821, 7555.282248186413, 7560.470767046254, 7563.168051514439, 7631.885521717068, 6671.366220209073, 6679.732810687518, 6773.18721753373, 6787.728490860311, 6882.346177113166, 6647.268800431852, 6688.464922806261, 6734.730610775514, 6790.898136527857, 6885.793426197222, 6001.7299221536005, 6149.784757533644, 6162.907556386747, 6173.444390004921, 6187.350328215653, 4516.525764794649, 4574.5425457453985, 4612.054528821516, 4617.007343421181, 4734.644901632322, 4550.6587005974025, 4575.9771201143785, 4600.654950878765, 4602.516735742699, 4698.788554514987], "value": 4125.724322507666, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.88870229312863, 297.064247619997, 301.6305026342729, 302.5748822903821, 305.1410280061627, 4900.828471003516, 4905.583025442837, 4932.531409516095, 4938.629602779797, 4951.3810773653295, 4814.7351895645725, 4827.903441931159, 4886.291487734276, 4897.191963326056, 4897.559219670229, 3547.822608869559, 3675.4854320395166, 3677.760945538545, 3814.179951310468, 3835.712321575879, 3804.7526910750853, 3810.637989391017, 3814.866479673212, 3840.2127563849344, 3847.634474724897, 3766.6045065268163, 3771.1326394929183, 3782.829772660237, 3787.3561494545856, 3806.657400833938, 3481.756277060607, 3522.1722895119497, 3653.707703383723, 3664.2121943782213, 3778.9622103779025, 3322.235885746292, 3326.6340702522702, 3346.8493917773517, 3362.411577973845, 3372.173817414749, 4652.883677908079, 4667.813287468532, 4678.532146785295, 4702.271147972036, 4720.150372932871, 4236.707804119742, 4353.0423306872435, 4358.716683415568, 4360.106178233455, 4366.454193225847, 4986.501349864984, 4997.075541024886, 5019.272205530177, 5053.393592768854, 5080.237964305384, 3652.251288485854, 3665.87169449068, 3680.355937710917, 3681.061329360996, 3686.447032945053, 5142.5628821549835, 5311.2298716686255, 5349.625526213166, 5355.892882142335, 5356.785728570852, 3670.6879915206973, 3671.7796932184156, 3685.8157092145284, 3708.276886007203, 3711.7958512282084, 3738.9626103738615, 3741.9438708419398, 3756.7745935243424, 3768.4535742317757, 3782.829772660237, 4268.658507319469, 4269.3595960605535, 4282.550332215073, 4287.399764033038, 4310.159518893848, 4859.271109333628, 5006.0989021975665, 5022.949770502321, 5030.270610761419, 5046.571041461443, 1292.9224246545236, 1314.1786383510307, 1320.9867901320863, 1323.8146659467682, 1325.1055537512334, 816.9060558035783, 850.5534594337898, 855.9786005349916, 872.6640243506168, 879.8944126704708, 3978.647259931637, 3986.5016872890887, 4238.936415953764, 4364.1708075466195, 4400.44994375703, 5197.948020519746, 5205.984832957537, 5206.297149884793, 5208.427073021964, 5210.6613070150315, 4450.866474005785, 4451.910961780811, 4461.442319710036, 4494.168578812864, 4494.573015563582, 2594.4811037792515, 2737.7536021758137, 2753.655793025872, 2758.3517873299757, 2758.4207316463367, 4859.2954021666665, 4870.172070747911, 4896.4858689837765, 4905.681130726492, 4906.779194936236, 5334.67991920486, 5340.25236466895, 5350.143976963667, 5364.195370694427, 5371.543418809445, 4677.508861569554, 4876.731779752147, 4897.363342765418, 4937.0, 4943.752812359439, 5247.1866860636665, 5268.947310526845, 5270.525652691276, 5273.602495338815, 5291.973540132275, 5117.385913690381, 5194.714290714047, 5196.896062078813, 5197.480251974772, 5216.686998780086, 4695.4834968154155, 4888.291197776373, 4908.214685650421, 4912.680675756064, 4914.926276105933, 3680.153564680085, 3704.407294832814, 3706.62933706638, 3715.9256814864093, 3731.5708693500596, 5290.523852853262, 5320.787168513216, 5320.946790532045, 5328.17413300939, 5331.546818520469, 4960.8759781005765, 5048.293238946477, 5129.820456284012, 5138.614603904647, 5140.074786538459, 5052.115879721107, 5074.238864170404, 5079.596670231028, 5088.491150884882, 5100.209467532539, 4995.302536630179, 5001.1498045331655, 5028.2960385546785, 5056.191009438472, 5059.898802023865, 4871.732054737024, 4889.828855990166, 5104.846854594368, 5117.565006974449, 5124.359455068116, 4837.016823102511, 4981.327520784647, 5000.099982003274, 5009.223570346602, 5011.7494125294315], "value": 3819.0546584377325, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [649.9935000649994, 675.567636712504, 705.3510770091515, 730.9963450182752, 746.6640011994602, 11800.760920103394, 12458.501659933603, 12522.624321270365, 12538.49846006161, 12540.435680394381, 13390.397432115555, 13505.257210853424, 13533.188008719459, 13539.323033848294, 13621.978351623644, 620.9844753881144, 745.3813334931993, 759.2786852490129, 770.3567521119871, 771.9112302085276, 766.7086507127311, 768.9653965571534, 773.0916173496148, 776.5845272779064, 779.793354760986, 816.5590581086207, 819.2994989284166, 819.7253919936828, 819.9344052475788, 819.9467034642729, 639.0892977507057, 658.6969993802857, 663.8838203314401, 668.8194187569329, 809.4131754478016, 579.7738881836087, 588.5497594340333, 592.2034863109111, 593.2643522032648, 594.2749845188863, 12977.805332920014, 13063.412146453433, 13068.215907045513, 13073.280969546671, 13107.47570097195, 11576.53693852245, 11790.469428875722, 12060.155789094679, 12084.758304833855, 12539.93730031344, 9975.401475911469, 10167.0, 11409.087273018138, 11457.312561246352, 11496.137789665809, 3972.543157536891, 4030.979845100785, 4114.979425102885, 4192.832286708528, 4212.85255016073, 49265.26102108471, 51599.22601161023, 61502.0, 61663.0, 62096.37903620996, 10110.747231319128, 10359.119474844572, 10476.895231047745, 10510.527026283835, 10691.198160138021, 18321.7251741224, 18376.264949402143, 18393.172307246205, 18395.080245987647, 18395.26418943254, 6870.587764734132, 6887.031823350389, 7051.5063945523325, 7105.857882842418, 7169.89245161323, 3520.6655367740536, 3586.4082426399873, 3611.9336136753627, 3612.5303710517464, 3686.0, 2866.9856650716615, 2949.8672559734864, 2955.7783166262616, 2960.18594886408, 2961.4077184563175, 495.0519754669767, 509.38110196111904, 512.0884825011411, 515.1474310016928, 518.9714565698923, 519.9038177937093, 521.7599904044106, 577.9133130030528, 583.582738342079, 598.9608030067828, 7771.212007878901, 7905.604719764104, 7935.920640793518, 8211.630476628567, 8269.46248493846, 479.5875547029552, 570.4751628501788, 595.8778450417655, 609.6860117039728, 611.7858749437661, 3721.14413684854, 3802.16352402471, 3837.194189220239, 3882.417637354363, 3961.1087505311652, 53984.0, 79109.20890791134, 89277.0, 98719.0, 99354.50322748485, 80740.0, 81305.59347203345, 81345.18654813494, 82648.58675706583, 84356.57821710852, 72293.0, 72626.63686681533, 73153.6342318285, 74530.0, 74578.0, 7822.765317040498, 8014.0, 8042.597870106589, 8194.42639015287, 8225.218604232588, 33543.49684754682, 39245.41131882967, 41006.384904225866, 44828.32757508575, 47153.0, 63219.68390158204, 63287.0, 63479.6826015867, 63483.0, 65920.0, 9936.354136981074, 10432.321899076536, 10797.514111865143, 10895.07391871668, 10910.959348295522, 12866.67833304175, 12928.516067489732, 13156.079074464695, 13278.402471888596, 13281.601551953458, 10885.78228435411, 10926.399048052433, 11371.090312775124, 11921.046316294849, 11967.042636588878, 9582.425054496753, 9658.855117173107, 9735.269854761063, 9755.317127800985, 9828.361156524803, 11543.36511491876, 11637.941810290895, 11942.522299107939, 12358.752824943631, 12439.689007774878, 8785.560721963748, 8792.0, 9051.411658242194, 9995.300328976902, 10057.69826905194, 8657.052163263215, 8982.236509896731, 9409.106134917172, 9446.574904129193, 9557.283203759607], "value": 6407.722265608064, "unit": "score"}], "name": "dromaeo_css", "value": 6386.799030736264, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 115.0, 115.0, 114.0, 115.0, 113.0, 113.0, 113.0, 114.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 122.0, 127.0, 186.0, 123.0, 123.0, 152.0, 123.0, 169.0, 121.0], "value": 139.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 160.0, 161.0, 162.0, 161.0, 161.0, 164.0, 164.0, 163.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 129.0, 75.0, 76.0, 74.0, 75.0, 101.0, 76.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 118.0, 85.0, 86.0, 87.0, 112.0, 85.0, 86.0, 131.0], "value": 96.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 63.0, 63.0, 65.0, 63.0, 63.0, 63.0, 63.0, 63.0], "value": 63.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 67.0, 67.0, 66.0, 66.0, 67.0, 66.0, 65.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 78.0, 82.0, 85.0, 79.0, 78.0, 79.0, 78.0, 78.0], "value": 79.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 129.0, 129.0, 130.0, 129.0, 129.0, 128.0, 129.0, 180.0, 143.0], "value": 137.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 169.0, 162.0, 163.0, 162.0, 163.0, 161.0, 162.0, 164.0, 161.0], "value": 162.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 66.0, 66.0, 68.0, 66.0, 66.0, 65.0, 67.0, 66.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1527.5, "alertThreshold": 2.0}]} 08:56:16 INFO - Return code: 0 08:56:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:56:16 INFO - # TBPL SUCCESS # 08:56:16 INFO - Running post-action listener: _resource_record_post_action 08:56:16 INFO - [mozharness: 2016-07-22 15:56:16.567120Z] Finished run-tests step (success) 08:56:16 INFO - Running post-run listener: _resource_record_post_run 08:56:16 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 495616; Write bytes: 540372992; Read time: 44; Write time: 522504 08:56:16 INFO - TinderboxPrint: CPU usage
13.0% 08:56:16 INFO - TinderboxPrint: I/O read bytes / time
495,616 / 44 08:56:16 INFO - TinderboxPrint: I/O write bytes / time
540,372,992 / 522,504 08:56:16 INFO - TinderboxPrint: CPU idle
8,340.9 (87.0%) 08:56:16 INFO - TinderboxPrint: CPU user
1,198.6 (12.5%) 08:56:16 INFO - TinderboxPrint: Swap in / out
0 / 0 08:56:16 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 250392576; Read time: 0; Write time: 236928 08:56:16 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 495616; Write bytes: 289980416; Read time: 44; Write time: 285576 08:56:17 INFO - Running post-run listener: _upload_blobber_files 08:56:17 INFO - Blob upload gear active. 08:56:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:56:17 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 08:56:17 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'] 08:56:17 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 08:56:17 INFO - (blobuploader) - INFO - Open directory for files ... 08:56:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:56:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:56:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:56:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:56:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:56:18 INFO - (blobuploader) - INFO - Done attempting. 08:56:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:56:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:56:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:56:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:56:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:56:31 INFO - (blobuploader) - INFO - Done attempting. 08:56:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:56:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:56:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:56:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:56:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:56:32 INFO - (blobuploader) - INFO - Done attempting. 08:56:32 INFO - (blobuploader) - INFO - Iteration through files over. 08:56:32 INFO - Return code: 0 08:56:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:56:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:56:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/39a9ccda370508dc59faeb42eeefd9346a2a6b2ff09f2dc86d5d04598282515f2ca9c575c964b7feba29cc0c4f773ae3cc601276e0e22835a9afb6071db1a261", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b426f5dd6cfff2b0c02f79dae918bbee6b061bf551e066218ce6fea5a39de0d7d5e1af48dfce97ed568b47c78eaa003ecb11657f77e4a071dc38a7f71af0ea27", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/445ee098fb2beb3a7845fbbf305e3bf1715b0a47ed8b0225267227175e622558693725ea096858636f7ae81c6ccf7f3b2f876d3ec797f1fe3bc0b8d397919651"} 08:56:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:56:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:56:32 INFO - Contents: 08:56:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/39a9ccda370508dc59faeb42eeefd9346a2a6b2ff09f2dc86d5d04598282515f2ca9c575c964b7feba29cc0c4f773ae3cc601276e0e22835a9afb6071db1a261", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b426f5dd6cfff2b0c02f79dae918bbee6b061bf551e066218ce6fea5a39de0d7d5e1af48dfce97ed568b47c78eaa003ecb11657f77e4a071dc38a7f71af0ea27", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/445ee098fb2beb3a7845fbbf305e3bf1715b0a47ed8b0225267227175e622558693725ea096858636f7ae81c6ccf7f3b2f876d3ec797f1fe3bc0b8d397919651"} 08:56:32 INFO - Running post-run listener: copy_logs_to_upload_dir 08:56:32 INFO - Copying logs to upload dir... 08:56:32 INFO - mkdir: /builds/slave/test/build/upload/logs 08:56:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.488891 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-07-22 08:56:32.258491) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-22 08:56:32.263331) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1469201741.255-1261785442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/39a9ccda370508dc59faeb42eeefd9346a2a6b2ff09f2dc86d5d04598282515f2ca9c575c964b7feba29cc0c4f773ae3cc601276e0e22835a9afb6071db1a261", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b426f5dd6cfff2b0c02f79dae918bbee6b061bf551e066218ce6fea5a39de0d7d5e1af48dfce97ed568b47c78eaa003ecb11657f77e4a071dc38a7f71af0ea27", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/445ee098fb2beb3a7845fbbf305e3bf1715b0a47ed8b0225267227175e622558693725ea096858636f7ae81c6ccf7f3b2f876d3ec797f1fe3bc0b8d397919651"} build_url:https://queue.taskcluster.net/v1/task/TjzSkRXaSjOvNfAcPzLQ7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011265 build_url: 'https://queue.taskcluster.net/v1/task/TjzSkRXaSjOvNfAcPzLQ7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/39a9ccda370508dc59faeb42eeefd9346a2a6b2ff09f2dc86d5d04598282515f2ca9c575c964b7feba29cc0c4f773ae3cc601276e0e22835a9afb6071db1a261", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b426f5dd6cfff2b0c02f79dae918bbee6b061bf551e066218ce6fea5a39de0d7d5e1af48dfce97ed568b47c78eaa003ecb11657f77e4a071dc38a7f71af0ea27", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/445ee098fb2beb3a7845fbbf305e3bf1715b0a47ed8b0225267227175e622558693725ea096858636f7ae81c6ccf7f3b2f876d3ec797f1fe3bc0b8d397919651"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-22 08:56:32.293534) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 08:56:32.294298) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1469201741.255-1261785442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004388 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 08:56:32.377597) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-22 08:56:32.377948) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-22 08:56:32.378629) ========= ========= Total master_lag: 0.20 =========