builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-031 starttime: 1470356396.79 results: success (0) buildid: 20160804143003 builduid: 98e19d50e341477abb16d71907d9e702 revision: c60886d5c003908affbe74e56a7c5b88021b4c6e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 17:19:56.792138) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 17:19:56.792624) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 17:19:56.792938) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 17:19:56.827653) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 17:19:56.827936) ========= 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=db0483c52d987ecb441a263b000001ad-1470356198.260135-1506876525 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-04 17:19:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 89.2M=0s 2016-08-04 17:19:57 (89.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.127238 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 17:19:56.970888) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 17:19:56.971205) ========= 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=db0483c52d987ecb441a263b000001ad-1470356198.260135-1506876525 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017616 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 17:19:57.021560) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-04 17:19:57.021956) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c60886d5c003908affbe74e56a7c5b88021b4c6e --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 c60886d5c003908affbe74e56a7c5b88021b4c6e --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=db0483c52d987ecb441a263b000001ad-1470356198.260135-1506876525 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-04 17:19:57,186 truncating revision to first 12 chars 2016-08-04 17:19:57,186 Setting DEBUG logging. 2016-08-04 17:19:57,186 attempt 1/10 2016-08-04 17:19:57,186 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c60886d5c003?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-04 17:19:58,489 unpacking tar archive at: fx-team-c60886d5c003/testing/mozharness/ program finished with exit code 0 elapsedTime=1.740279 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-04 17:19:58.776778) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 17:19:58.777147) ========= script_repo_revision: c60886d5c003908affbe74e56a7c5b88021b4c6e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 17:19:58.777631) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 17:19:58.777916) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 17:19:58.788617) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-08-04 17:19:58.789033) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=db0483c52d987ecb441a263b000001ad-1470356198.260135-1506876525 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:19:59 INFO - MultiFileLogger online at 20160804 17:19:59 in /builds/slave/test 17:19:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:19:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:19:59 INFO - {'append_to_log': False, 17:19:59 INFO - 'base_work_dir': '/builds/slave/test', 17:19:59 INFO - 'blob_upload_branch': 'Fx-Team', 17:19:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:19:59 INFO - 'branch': 'Fx-Team', 17:19:59 INFO - 'buildbot_json_path': 'buildprops.json', 17:19:59 INFO - 'config_files': ('talos/linux_config.py',), 17:19:59 INFO - 'default_actions': ('clobber', 17:19:59 INFO - 'read-buildbot-config', 17:19:59 INFO - 'download-and-extract', 17:19:59 INFO - 'populate-webroot', 17:19:59 INFO - 'create-virtualenv', 17:19:59 INFO - 'install', 17:19:59 INFO - 'run-tests'), 17:19:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:19:59 INFO - 'download_minidump_stackwalk': True, 17:19:59 INFO - 'download_symbols': 'ondemand', 17:19:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:19:59 INFO - 'tooltool.py': '/tools/tooltool.py', 17:19:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:19:59 INFO - '/tools/misc-python/virtualenv.py')}, 17:19:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:19:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:19:59 INFO - 'installer_path': 'installer.exe', 17:19:59 INFO - 'log_level': 'info', 17:19:59 INFO - 'log_name': 'talos', 17:19:59 INFO - 'log_to_console': True, 17:19:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:19:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:19:59 INFO - 'opt_config_files': (), 17:19:59 INFO - 'pip_index': False, 17:19:59 INFO - 'sps_profile': False, 17:19:59 INFO - 'sps_profile_interval': 0, 17:19:59 INFO - 'suite': 'dromaeojs', 17:19:59 INFO - 'system_bits': '32', 17:19:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:19:59 INFO - 'title': 'talos-linux64-ix-031', 17:19:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:19:59 INFO - 'use_talos_json': True, 17:19:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:19:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:19:59 INFO - 'work_dir': 'build'} 17:19:59 INFO - [mozharness: 2016-08-05 00:19:59.047114Z] Running clobber step. 17:19:59 INFO - Running pre-action listener: _resource_record_pre_action 17:19:59 INFO - Running main action method: clobber 17:19:59 INFO - rmtree: /builds/slave/test/build 17:19:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:19:59 INFO - Running post-action listener: _resource_record_post_action 17:19:59 INFO - [mozharness: 2016-08-05 00:19:59.507958Z] Finished clobber step (success) 17:19:59 INFO - [mozharness: 2016-08-05 00:19:59.508059Z] Running read-buildbot-config step. 17:19:59 INFO - Running pre-action listener: _resource_record_pre_action 17:19:59 INFO - Running main action method: read_buildbot_config 17:19:59 INFO - Using buildbot properties: 17:19:59 INFO - { 17:19:59 INFO - "project": "", 17:19:59 INFO - "product": "firefox", 17:19:59 INFO - "script_repo_revision": "production", 17:19:59 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:19:59 INFO - "repository": "", 17:19:59 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 17:19:59 INFO - "buildid": "20160804143003", 17:19:59 INFO - "pgo_build": "True", 17:19:59 INFO - "basedir": "/builds/slave/test", 17:19:59 INFO - "buildnumber": 1419, 17:19:59 INFO - "slavename": "talos-linux64-ix-031", 17:19:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:19:59 INFO - "platform": "ubuntu64_hw", 17:19:59 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:19:59 INFO - "branch": "fx-team", 17:19:59 INFO - "repo_path": "integration/fx-team", 17:19:59 INFO - "revision": "c60886d5c003908affbe74e56a7c5b88021b4c6e", 17:19:59 INFO - "stage_platform": "linux64-pgo", 17:19:59 INFO - "builduid": "98e19d50e341477abb16d71907d9e702", 17:19:59 INFO - "slavebuilddir": "test" 17:19:59 INFO - } 17:19:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/Pbuz5S7lTSu88t5EcIoUmA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 17:19:59 INFO - Running post-action listener: _resource_record_post_action 17:19:59 INFO - [mozharness: 2016-08-05 00:19:59.510530Z] Finished read-buildbot-config step (success) 17:19:59 INFO - [mozharness: 2016-08-05 00:19:59.510619Z] Running download-and-extract step. 17:19:59 INFO - Running pre-action listener: _resource_record_pre_action 17:19:59 INFO - Running main action method: download_and_extract 17:19:59 INFO - mkdir: /builds/slave/test/build/tests 17:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:19:59 INFO - trying https://queue.taskcluster.net/v1/task/Pbuz5S7lTSu88t5EcIoUmA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 17:19:59 INFO - Downloading https://queue.taskcluster.net/v1/task/Pbuz5S7lTSu88t5EcIoUmA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 17:19:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Pbuz5S7lTSu88t5EcIoUmA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:20:00 INFO - Downloaded 1361 bytes. 17:20:00 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 17:20:00 INFO - Using the following test package requirements: 17:20:00 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 17:20:00 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:20:00 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:20:00 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:20:00 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:20:00 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:20:00 INFO - u'jsshell-linux-x86_64.zip'], 17:20:00 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:20:00 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:20:00 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 17:20:00 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:20:00 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:20:00 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:20:00 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:20:00 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:20:00 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:20:00 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:20:00 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:20:00 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:20:00 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:20:00 INFO - trying https://queue.taskcluster.net/v1/task/Pbuz5S7lTSu88t5EcIoUmA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:20:00 INFO - Downloading https://queue.taskcluster.net/v1/task/Pbuz5S7lTSu88t5EcIoUmA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:20:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pbuz5S7lTSu88t5EcIoUmA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:20:01 INFO - Downloaded 21821025 bytes. 17:20:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:20:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:20:02 INFO - Return code: 0 17:20:02 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:20:02 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:20:02 INFO - trying https://queue.taskcluster.net/v1/task/Pbuz5S7lTSu88t5EcIoUmA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:20:02 INFO - Downloading https://queue.taskcluster.net/v1/task/Pbuz5S7lTSu88t5EcIoUmA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:20:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pbuz5S7lTSu88t5EcIoUmA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:20:03 INFO - Downloaded 21821025 bytes. 17:20:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:20:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:20:04 INFO - Return code: 0 17:20:04 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:20:04 INFO - trying https://queue.taskcluster.net/v1/task/Pbuz5S7lTSu88t5EcIoUmA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 17:20:04 INFO - Downloading https://queue.taskcluster.net/v1/task/Pbuz5S7lTSu88t5EcIoUmA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 17:20:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pbuz5S7lTSu88t5EcIoUmA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:20:06 INFO - Downloaded 14413723 bytes. 17:20:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:20:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:20:06 INFO - Return code: 0 17:20:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:20:06 INFO - trying https://queue.taskcluster.net/v1/task/Pbuz5S7lTSu88t5EcIoUmA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:20:06 INFO - Downloading https://queue.taskcluster.net/v1/task/Pbuz5S7lTSu88t5EcIoUmA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:20:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Pbuz5S7lTSu88t5EcIoUmA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:20:08 INFO - Downloaded 59346989 bytes. 17:20:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Pbuz5S7lTSu88t5EcIoUmA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:20:08 INFO - mkdir: /builds/slave/test/properties 17:20:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:20:08 INFO - Writing to file /builds/slave/test/properties/build_url 17:20:08 INFO - Contents: 17:20:08 INFO - build_url:https://queue.taskcluster.net/v1/task/Pbuz5S7lTSu88t5EcIoUmA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:20:09 INFO - Running post-action listener: _resource_record_post_action 17:20:09 INFO - Running post-action listener: set_extra_try_arguments 17:20:09 INFO - [mozharness: 2016-08-05 00:20:09.167779Z] Finished download-and-extract step (success) 17:20:09 INFO - [mozharness: 2016-08-05 00:20:09.168010Z] Running populate-webroot step. 17:20:09 INFO - Running pre-action listener: _resource_record_pre_action 17:20:09 INFO - Running main action method: populate_webroot 17:20:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:20:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:20:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:20:09 INFO - '--tppagecycles', 17:20:09 INFO - '7'], 17:20:09 INFO - 'tests': ['tsvgm']}}, 17:20:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:20:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:20:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:20:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:20:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:20:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:20:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:20:09 INFO - 'talos_options': ['--disable-e10s'], 17:20:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:20:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:20:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:20:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:20:09 INFO - 'talos_options': ['--disable-e10s'], 17:20:09 INFO - 'tests': ['damp', 'tps']}, 17:20:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:20:09 INFO - 'tests': ['damp', 'tps']}, 17:20:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:20:09 INFO - 'tests': ['dromaeo_dom']}, 17:20:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:20:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:20:09 INFO - 'tests': ['basic_compositor_video']}, 17:20:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:20:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:20:09 INFO - 'tests': ['a11yr', 17:20:09 INFO - 'ts_paint', 17:20:09 INFO - 'tpaint', 17:20:09 INFO - 'sessionrestore', 17:20:09 INFO - 'sessionrestore_no_auto_restore', 17:20:09 INFO - 'tabpaint']}, 17:20:09 INFO - 'other-e10s': {'tests': ['a11yr', 17:20:09 INFO - 'ts_paint', 17:20:09 INFO - 'tpaint', 17:20:09 INFO - 'sessionrestore', 17:20:09 INFO - 'sessionrestore_no_auto_restore', 17:20:09 INFO - 'tabpaint']}, 17:20:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:20:09 INFO - 'ts_paint', 17:20:09 INFO - 'tpaint', 17:20:09 INFO - 'sessionrestore', 17:20:09 INFO - 'sessionrestore_no_auto_restore', 17:20:09 INFO - 'tabpaint']}, 17:20:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:20:09 INFO - 'ts_paint', 17:20:09 INFO - 'tpaint', 17:20:09 INFO - 'sessionrestore', 17:20:09 INFO - 'sessionrestore_no_auto_restore', 17:20:09 INFO - 'tabpaint']}, 17:20:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:20:09 INFO - 'tests': ['a11yr', 17:20:09 INFO - 'ts_paint', 17:20:09 INFO - 'tpaint', 17:20:09 INFO - 'sessionrestore', 17:20:09 INFO - 'sessionrestore_no_auto_restore', 17:20:09 INFO - 'tabpaint']}, 17:20:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:20:09 INFO - 'tests': ['a11yr', 17:20:09 INFO - 'ts_paint', 17:20:09 INFO - 'tpaint', 17:20:09 INFO - 'sessionrestore', 17:20:09 INFO - 'sessionrestore_no_auto_restore', 17:20:09 INFO - 'tabpaint']}, 17:20:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:20:09 INFO - 'tests': ['tsvgx', 17:20:09 INFO - 'tsvgr_opacity', 17:20:09 INFO - 'tart', 17:20:09 INFO - 'tscrollx', 17:20:09 INFO - 'cart']}, 17:20:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:20:09 INFO - 'tsvgr_opacity', 17:20:09 INFO - 'tart', 17:20:09 INFO - 'tscrollx', 17:20:09 INFO - 'cart']}, 17:20:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:20:09 INFO - 'talos_options': ['--disable-e10s'], 17:20:09 INFO - 'tests': ['tp5o']}, 17:20:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:20:09 INFO - 'tests': ['tp5o']}, 17:20:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:20:09 INFO - 'talos_options': ['--disable-e10s', 17:20:09 INFO - '--xperf_path', 17:20:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:20:09 INFO - 'tests': ['tp5n']}, 17:20:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:20:09 INFO - 'talos_options': ['--xperf_path', 17:20:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:20:09 INFO - 'tests': ['tp5n']}}, 17:20:09 INFO - 'talos.zip': {'path': '', 17:20:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:20:09 INFO - Running post-action listener: _resource_record_post_action 17:20:09 INFO - [mozharness: 2016-08-05 00:20:09.184759Z] Finished populate-webroot step (success) 17:20:09 INFO - [mozharness: 2016-08-05 00:20:09.184847Z] Running create-virtualenv step. 17:20:09 INFO - Running pre-action listener: _resource_record_pre_action 17:20:09 INFO - Running main action method: create_virtualenv 17:20:09 INFO - Creating virtualenv /builds/slave/test/build/venv 17:20:09 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 17:20:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:20:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:20:09 INFO - Using real prefix '/usr' 17:20:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:20:09 INFO - Installing distribute.............................................................................................................................................................................................done. 17:20:11 INFO - Installing pip.................done. 17:20:11 INFO - Return code: 0 17:20:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:20:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:20:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:20:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:11 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 0x1684030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1945180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19433b0>, '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 0x19442b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1944740>, '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': 'db0483c52d987ecb441a263b000001ad-1470356198.260135-1506876525', '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 17:20:11 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 17:20:11 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 17:20:11 INFO - Using env: {'DISPLAY': ':0', 17:20:11 INFO - 'HOME': '/home/cltbld', 17:20:11 INFO - 'LANG': 'en_US.UTF-8', 17:20:11 INFO - 'LANGUAGE': 'en_US:en', 17:20:11 INFO - 'LOGNAME': 'cltbld', 17:20:11 INFO - 'MAIL': '/var/mail/cltbld', 17:20:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:11 INFO - 'MOZ_NO_REMOTE': '1', 17:20:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:11 INFO - 'NO_EM_RESTART': '1', 17:20:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:11 INFO - 'PWD': '/builds/slave/test', 17:20:11 INFO - 'SHELL': '/bin/bash', 17:20:11 INFO - 'SHLVL': '1', 17:20:11 INFO - 'TERM': 'linux', 17:20:11 INFO - 'TMOUT': '86400', 17:20:11 INFO - 'USER': 'cltbld', 17:20:11 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1470356198.260135-1506876525', 17:20:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:11 INFO - '_': '/tools/buildbot/bin/python'} 17:20:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:11 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 17:20:11 INFO - Cleaning up... 17:20:11 INFO - Return code: 0 17:20:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:20:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:20:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:20:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:11 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 0x1684030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1945180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19433b0>, '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 0x19442b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1944740>, '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': 'db0483c52d987ecb441a263b000001ad-1470356198.260135-1506876525', '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 17:20:11 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 17:20:11 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 17:20:11 INFO - Using env: {'DISPLAY': ':0', 17:20:11 INFO - 'HOME': '/home/cltbld', 17:20:11 INFO - 'LANG': 'en_US.UTF-8', 17:20:11 INFO - 'LANGUAGE': 'en_US:en', 17:20:11 INFO - 'LOGNAME': 'cltbld', 17:20:11 INFO - 'MAIL': '/var/mail/cltbld', 17:20:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:11 INFO - 'MOZ_NO_REMOTE': '1', 17:20:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:11 INFO - 'NO_EM_RESTART': '1', 17:20:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:11 INFO - 'PWD': '/builds/slave/test', 17:20:11 INFO - 'SHELL': '/bin/bash', 17:20:11 INFO - 'SHLVL': '1', 17:20:11 INFO - 'TERM': 'linux', 17:20:11 INFO - 'TMOUT': '86400', 17:20:11 INFO - 'USER': 'cltbld', 17:20:11 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1470356198.260135-1506876525', 17:20:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:11 INFO - '_': '/tools/buildbot/bin/python'} 17:20:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:12 INFO - Downloading/unpacking psutil>=3.1.1 17:20:12 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 17:20:12 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 17:20:12 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 17:20:12 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 17:20:12 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 17:20:12 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 17:20:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:20:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:20:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:20:14 INFO - Installing collected packages: psutil 17:20:14 INFO - Running setup.py install for psutil 17:20:14 INFO - building 'psutil._psutil_linux' extension 17:20:14 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 17:20:14 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 17:20:14 INFO - building 'psutil._psutil_posix' extension 17:20:14 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 17:20:14 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 17:20:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:20:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:20:14 INFO - Successfully installed psutil 17:20:14 INFO - Cleaning up... 17:20:14 INFO - Return code: 0 17:20:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:20: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:20:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1684030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1945180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19433b0>, '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 0x19442b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1944740>, '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': 'db0483c52d987ecb441a263b000001ad-1470356198.260135-1506876525', '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 17:20: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:20: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 mozsystemmonitor==0.3 17:20:14 INFO - Using env: {'DISPLAY': ':0', 17:20:14 INFO - 'HOME': '/home/cltbld', 17:20:14 INFO - 'LANG': 'en_US.UTF-8', 17:20:14 INFO - 'LANGUAGE': 'en_US:en', 17:20:14 INFO - 'LOGNAME': 'cltbld', 17:20:14 INFO - 'MAIL': '/var/mail/cltbld', 17:20:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:14 INFO - 'MOZ_NO_REMOTE': '1', 17:20:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:14 INFO - 'NO_EM_RESTART': '1', 17:20:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:14 INFO - 'PWD': '/builds/slave/test', 17:20:14 INFO - 'SHELL': '/bin/bash', 17:20:14 INFO - 'SHLVL': '1', 17:20:14 INFO - 'TERM': 'linux', 17:20:14 INFO - 'TMOUT': '86400', 17:20:14 INFO - 'USER': 'cltbld', 17:20:14 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1470356198.260135-1506876525', 17:20:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:14 INFO - '_': '/tools/buildbot/bin/python'} 17:20:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:20:14 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 17:20:14 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 17:20:14 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 17:20:14 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 17:20:14 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 17:20:14 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 17:20:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:20:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:20:16 INFO - Installing collected packages: mozsystemmonitor 17:20:16 INFO - Running setup.py install for mozsystemmonitor 17:20:16 INFO - Successfully installed mozsystemmonitor 17:20:16 INFO - Cleaning up... 17:20:17 INFO - Return code: 0 17:20:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:20:17 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:20:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:17 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:20:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:17 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 0x1684030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1945180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19433b0>, '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 0x19442b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1944740>, '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': 'db0483c52d987ecb441a263b000001ad-1470356198.260135-1506876525', '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 17:20:17 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 17:20:17 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 17:20:17 INFO - Using env: {'DISPLAY': ':0', 17:20:17 INFO - 'HOME': '/home/cltbld', 17:20:17 INFO - 'LANG': 'en_US.UTF-8', 17:20:17 INFO - 'LANGUAGE': 'en_US:en', 17:20:17 INFO - 'LOGNAME': 'cltbld', 17:20:17 INFO - 'MAIL': '/var/mail/cltbld', 17:20:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:17 INFO - 'MOZ_NO_REMOTE': '1', 17:20:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:17 INFO - 'NO_EM_RESTART': '1', 17:20:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:17 INFO - 'PWD': '/builds/slave/test', 17:20:17 INFO - 'SHELL': '/bin/bash', 17:20:17 INFO - 'SHLVL': '1', 17:20:17 INFO - 'TERM': 'linux', 17:20:17 INFO - 'TMOUT': '86400', 17:20:17 INFO - 'USER': 'cltbld', 17:20:17 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1470356198.260135-1506876525', 17:20:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:17 INFO - '_': '/tools/buildbot/bin/python'} 17:20:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:17 INFO - Downloading/unpacking jsonschema==2.5.1 17:20:17 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 17:20:17 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 17:20:17 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 17:20:17 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 17:20:17 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 17:20:17 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 17:20:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:20:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:20:19 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 17:20:19 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 17:20:19 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 17:20:19 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 17:20:19 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 17:20:19 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 17:20:19 INFO - Downloading functools32-3.2.3-2.tar.gz 17:20:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:20:19 INFO - warning: no files found matching '*.txt' 17:20:19 INFO - no previously-included directories found matching 'build' 17:20:19 INFO - no previously-included directories found matching 'dist' 17:20:19 INFO - no previously-included directories found matching '.git*' 17:20:19 INFO - Installing collected packages: jsonschema, functools32 17:20:19 INFO - Running setup.py install for functools32 17:20:19 INFO - warning: no files found matching '*.txt' 17:20:19 INFO - no previously-included directories found matching 'build' 17:20:19 INFO - no previously-included directories found matching 'dist' 17:20:19 INFO - no previously-included directories found matching '.git*' 17:20:19 INFO - Successfully installed jsonschema functools32 17:20:19 INFO - Cleaning up... 17:20:19 INFO - Return code: 0 17:20:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:20:19 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:19 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:20:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:19 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1684030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1945180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19433b0>, '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 0x19442b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1944740>, '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': 'db0483c52d987ecb441a263b000001ad-1470356198.260135-1506876525', '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 17:20:19 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:20:19 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 functools32==3.2.3-2 17:20:19 INFO - Using env: {'DISPLAY': ':0', 17:20:19 INFO - 'HOME': '/home/cltbld', 17:20:19 INFO - 'LANG': 'en_US.UTF-8', 17:20:19 INFO - 'LANGUAGE': 'en_US:en', 17:20:19 INFO - 'LOGNAME': 'cltbld', 17:20:19 INFO - 'MAIL': '/var/mail/cltbld', 17:20:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:19 INFO - 'MOZ_NO_REMOTE': '1', 17:20:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:19 INFO - 'NO_EM_RESTART': '1', 17:20:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:19 INFO - 'PWD': '/builds/slave/test', 17:20:19 INFO - 'SHELL': '/bin/bash', 17:20:19 INFO - 'SHLVL': '1', 17:20:19 INFO - 'TERM': 'linux', 17:20:19 INFO - 'TMOUT': '86400', 17:20:19 INFO - 'USER': 'cltbld', 17:20:19 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1470356198.260135-1506876525', 17:20:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:19 INFO - '_': '/tools/buildbot/bin/python'} 17:20:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:20:19 INFO - Cleaning up... 17:20:19 INFO - Return code: 0 17:20:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:20:19 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:19 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:20:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:19 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 0x1684030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1945180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19433b0>, '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 0x19442b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1944740>, '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': 'db0483c52d987ecb441a263b000001ad-1470356198.260135-1506876525', '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 17:20:19 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 17:20:19 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 17:20:19 INFO - Using env: {'DISPLAY': ':0', 17:20:19 INFO - 'HOME': '/home/cltbld', 17:20:19 INFO - 'LANG': 'en_US.UTF-8', 17:20:19 INFO - 'LANGUAGE': 'en_US:en', 17:20:19 INFO - 'LOGNAME': 'cltbld', 17:20:19 INFO - 'MAIL': '/var/mail/cltbld', 17:20:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:19 INFO - 'MOZ_NO_REMOTE': '1', 17:20:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:19 INFO - 'NO_EM_RESTART': '1', 17:20:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:19 INFO - 'PWD': '/builds/slave/test', 17:20:19 INFO - 'SHELL': '/bin/bash', 17:20:19 INFO - 'SHLVL': '1', 17:20:19 INFO - 'TERM': 'linux', 17:20:19 INFO - 'TMOUT': '86400', 17:20:19 INFO - 'USER': 'cltbld', 17:20:19 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1470356198.260135-1506876525', 17:20:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:19 INFO - '_': '/tools/buildbot/bin/python'} 17:20:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:19 INFO - Downloading/unpacking blobuploader==1.2.4 17:20:19 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 17:20:19 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 17:20:19 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 17:20:19 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 17:20:19 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 17:20:19 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 17:20:21 INFO - Downloading blobuploader-1.2.4.tar.gz 17:20:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:20:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:20:21 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 17:20:21 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 17:20:21 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 17:20:21 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 17:20:21 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 17:20:21 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 17:20:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:20:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:20:22 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 17:20:22 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 17:20:22 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 17:20:22 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 17:20:22 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 17:20:22 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 17:20:22 INFO - Downloading docopt-0.6.1.tar.gz 17:20:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:20:22 INFO - Installing collected packages: blobuploader, requests, docopt 17:20:22 INFO - Running setup.py install for blobuploader 17:20:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:20:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:20:22 INFO - Running setup.py install for requests 17:20:23 INFO - Running setup.py install for docopt 17:20:23 INFO - Successfully installed blobuploader requests docopt 17:20:23 INFO - Cleaning up... 17:20:23 INFO - Return code: 0 17:20:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:20:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:20:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:20:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:23 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 0x1684030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1945180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19433b0>, '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 0x19442b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1944740>, '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': 'db0483c52d987ecb441a263b000001ad-1470356198.260135-1506876525', '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 17:20:23 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 17:20:23 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 17:20:23 INFO - Using env: {'DISPLAY': ':0', 17:20:23 INFO - 'HOME': '/home/cltbld', 17:20:23 INFO - 'LANG': 'en_US.UTF-8', 17:20:23 INFO - 'LANGUAGE': 'en_US:en', 17:20:23 INFO - 'LOGNAME': 'cltbld', 17:20:23 INFO - 'MAIL': '/var/mail/cltbld', 17:20:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:23 INFO - 'MOZ_NO_REMOTE': '1', 17:20:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:23 INFO - 'NO_EM_RESTART': '1', 17:20:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:23 INFO - 'PWD': '/builds/slave/test', 17:20:23 INFO - 'SHELL': '/bin/bash', 17:20:23 INFO - 'SHLVL': '1', 17:20:23 INFO - 'TERM': 'linux', 17:20:23 INFO - 'TMOUT': '86400', 17:20:23 INFO - 'USER': 'cltbld', 17:20:23 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1470356198.260135-1506876525', 17:20:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:23 INFO - '_': '/tools/buildbot/bin/python'} 17:20:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:20:23 INFO - Running setup.py (path:/tmp/pip-Ppy6d1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:20:23 INFO - Running setup.py (path:/tmp/pip-9edabD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:20:23 INFO - Running setup.py (path:/tmp/pip-TlKWA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:20:23 INFO - Running setup.py (path:/tmp/pip-d4Jh0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:20:23 INFO - Running setup.py (path:/tmp/pip-obttm4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:20:23 INFO - Running setup.py (path:/tmp/pip-vXtupM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:20:23 INFO - Running setup.py (path:/tmp/pip-RL7rcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:20:23 INFO - Running setup.py (path:/tmp/pip-ZB5cRL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:20:24 INFO - Running setup.py (path:/tmp/pip-fN9XxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:20:24 INFO - Running setup.py (path:/tmp/pip-2HCFtb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:20:24 INFO - Running setup.py (path:/tmp/pip-8wKmxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:20:24 INFO - Running setup.py (path:/tmp/pip-sYYfhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:20:24 INFO - Running setup.py (path:/tmp/pip-F1Sy4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:20:24 INFO - Running setup.py (path:/tmp/pip-UUJ7BC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:20:24 INFO - Running setup.py (path:/tmp/pip-p1QmVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:20:24 INFO - Running setup.py (path:/tmp/pip-q0zjVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:20:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:20:24 INFO - Running setup.py (path:/tmp/pip-TIdZ4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:20:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:20:24 INFO - Running setup.py install for manifestparser 17:20:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:20:24 INFO - Running setup.py install for mozcrash 17:20:24 INFO - Running setup.py install for mozdebug 17:20:24 INFO - Running setup.py install for mozdevice 17:20:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:20:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:20:25 INFO - Running setup.py install for mozfile 17:20:25 INFO - Running setup.py install for mozhttpd 17:20:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:20:25 INFO - Running setup.py install for mozinfo 17:20:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:20:25 INFO - Running setup.py install for mozInstall 17:20:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:20:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:20:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:20:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:20:25 INFO - Running setup.py install for mozleak 17:20:25 INFO - Running setup.py install for mozlog 17:20:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:20:25 INFO - Running setup.py install for moznetwork 17:20:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:20:25 INFO - Running setup.py install for mozprocess 17:20:25 INFO - Running setup.py install for mozprofile 17:20:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:20:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:20:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:20:26 INFO - Running setup.py install for mozrunner 17:20:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:20:26 INFO - Running setup.py install for mozscreenshot 17:20:26 INFO - Running setup.py install for moztest 17:20:26 INFO - Running setup.py install for mozversion 17:20:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:20:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:20:26 INFO - Cleaning up... 17:20:26 INFO - Return code: 0 17:20:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:20:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:20:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:20:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:26 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 0x1684030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1945180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19433b0>, '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 0x19442b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1944740>, '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': 'db0483c52d987ecb441a263b000001ad-1470356198.260135-1506876525', '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 17:20:26 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 17:20:26 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 17:20:26 INFO - Using env: {'DISPLAY': ':0', 17:20:26 INFO - 'HOME': '/home/cltbld', 17:20:26 INFO - 'LANG': 'en_US.UTF-8', 17:20:26 INFO - 'LANGUAGE': 'en_US:en', 17:20:26 INFO - 'LOGNAME': 'cltbld', 17:20:26 INFO - 'MAIL': '/var/mail/cltbld', 17:20:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:26 INFO - 'MOZ_NO_REMOTE': '1', 17:20:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:26 INFO - 'NO_EM_RESTART': '1', 17:20:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:26 INFO - 'PWD': '/builds/slave/test', 17:20:26 INFO - 'SHELL': '/bin/bash', 17:20:26 INFO - 'SHLVL': '1', 17:20:26 INFO - 'TERM': 'linux', 17:20:26 INFO - 'TMOUT': '86400', 17:20:26 INFO - 'USER': 'cltbld', 17:20:26 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1470356198.260135-1506876525', 17:20:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:26 INFO - '_': '/tools/buildbot/bin/python'} 17:20:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:20:26 INFO - Running setup.py (path:/tmp/pip-GSPAvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:20:26 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)) 17:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:20:26 INFO - Running setup.py (path:/tmp/pip-Nh2tOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:20:26 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)) 17:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:20:26 INFO - Running setup.py (path:/tmp/pip-Orvc9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:20:26 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)) 17:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:20:26 INFO - Running setup.py (path:/tmp/pip-Nbs0T0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:20:26 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)) 17:20:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:20:26 INFO - Running setup.py (path:/tmp/pip-g5e6Jd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:20:27 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)) 17:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:20:27 INFO - Running setup.py (path:/tmp/pip-4p4QMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:20:27 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)) 17:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:20:27 INFO - Running setup.py (path:/tmp/pip-QWfIto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:20:27 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)) 17:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:20:27 INFO - Running setup.py (path:/tmp/pip-3EU1WZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:20:27 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)) 17:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:20:27 INFO - Running setup.py (path:/tmp/pip-Aevznb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:20:27 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)) 17:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:20:27 INFO - Running setup.py (path:/tmp/pip-emdDf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:20:27 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)) 17:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:20:27 INFO - Running setup.py (path:/tmp/pip-QdZXAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:20:27 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)) 17:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:20:27 INFO - Running setup.py (path:/tmp/pip-sTMvoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:20:27 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)) 17:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:20:27 INFO - Running setup.py (path:/tmp/pip-7Pjqwz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:20:27 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)) 17:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:20:27 INFO - Running setup.py (path:/tmp/pip-iccbmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:20:27 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)) 17:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:20:27 INFO - Running setup.py (path:/tmp/pip-9cfznV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:20:27 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)) 17:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:20:27 INFO - Running setup.py (path:/tmp/pip-pold90-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:20:27 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)) 17:20:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:20:27 INFO - Running setup.py (path:/tmp/pip-Q8d94c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:20:27 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)) 17:20:27 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)) 17:20:27 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)) 17:20:27 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)) 17:20:27 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)) 17:20:27 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)) 17:20:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:20:27 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 17:20:27 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 17:20:27 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 17:20:27 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 17:20:27 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 17:20:27 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 17:20:29 INFO - Downloading blessings-1.6.tar.gz 17:20:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:20:29 INFO - Installing collected packages: blessings 17:20:29 INFO - Running setup.py install for blessings 17:20:29 INFO - Successfully installed blessings 17:20:29 INFO - Cleaning up... 17:20:30 INFO - Return code: 0 17:20:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:20:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:20:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:20:30 INFO - Reading from file tmpfile_stdout 17:20:30 INFO - Current package versions: 17:20:30 INFO - argparse == 1.2.1 17:20:30 INFO - blessings == 1.6 17:20:30 INFO - blobuploader == 1.2.4 17:20:30 INFO - docopt == 0.6.1 17:20:30 INFO - functools32 == 3.2.3-2 17:20:30 INFO - jsonschema == 2.5.1 17:20:30 INFO - manifestparser == 1.1 17:20:30 INFO - mozInstall == 1.12 17:20:30 INFO - mozcrash == 0.17 17:20:30 INFO - mozdebug == 0.1 17:20:30 INFO - mozdevice == 0.48 17:20:30 INFO - mozfile == 1.2 17:20:30 INFO - mozhttpd == 0.7 17:20:30 INFO - mozinfo == 0.9 17:20:30 INFO - mozleak == 0.1 17:20:30 INFO - mozlog == 3.3 17:20:30 INFO - moznetwork == 0.27 17:20:30 INFO - mozprocess == 0.23 17:20:30 INFO - mozprofile == 0.28 17:20:30 INFO - mozrunner == 6.12 17:20:30 INFO - mozscreenshot == 0.1 17:20:30 INFO - mozsystemmonitor == 0.3 17:20:30 INFO - moztest == 0.7 17:20:30 INFO - mozversion == 1.4 17:20:30 INFO - psutil == 3.1.1 17:20:30 INFO - requests == 1.2.3 17:20:30 INFO - wsgiref == 0.1.2 17:20:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:20:30 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:30 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:20:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:30 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 0x1684030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1945180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19433b0>, '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 0x19442b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1944740>, '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': 'db0483c52d987ecb441a263b000001ad-1470356198.260135-1506876525', '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 17:20:30 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 17:20:30 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 17:20:30 INFO - Using env: {'DISPLAY': ':0', 17:20:30 INFO - 'HOME': '/home/cltbld', 17:20:30 INFO - 'LANG': 'en_US.UTF-8', 17:20:30 INFO - 'LANGUAGE': 'en_US:en', 17:20:30 INFO - 'LOGNAME': 'cltbld', 17:20:30 INFO - 'MAIL': '/var/mail/cltbld', 17:20:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:30 INFO - 'MOZ_NO_REMOTE': '1', 17:20:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:30 INFO - 'NO_EM_RESTART': '1', 17:20:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:30 INFO - 'PWD': '/builds/slave/test', 17:20:30 INFO - 'SHELL': '/bin/bash', 17:20:30 INFO - 'SHLVL': '1', 17:20:30 INFO - 'TERM': 'linux', 17:20:30 INFO - 'TMOUT': '86400', 17:20:30 INFO - 'USER': 'cltbld', 17:20:30 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1470356198.260135-1506876525', 17:20:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:30 INFO - '_': '/tools/buildbot/bin/python'} 17:20:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:30 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)) 17:20:30 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)) 17:20:30 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)) 17:20:30 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)) 17:20:30 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)) 17:20:30 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)) 17:20:30 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)) 17:20:30 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)) 17:20:30 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)) 17:20:30 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)) 17:20:30 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)) 17:20:30 INFO - Cleaning up... 17:20:30 INFO - Return code: 0 17:20:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:20:30 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:30 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:20:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:30 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 0x1684030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1945180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19433b0>, '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 0x19442b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1944740>, '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': 'db0483c52d987ecb441a263b000001ad-1470356198.260135-1506876525', '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 17:20:30 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 17:20:30 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 17:20:30 INFO - Using env: {'DISPLAY': ':0', 17:20:30 INFO - 'HOME': '/home/cltbld', 17:20:30 INFO - 'LANG': 'en_US.UTF-8', 17:20:30 INFO - 'LANGUAGE': 'en_US:en', 17:20:30 INFO - 'LOGNAME': 'cltbld', 17:20:30 INFO - 'MAIL': '/var/mail/cltbld', 17:20:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:30 INFO - 'MOZ_NO_REMOTE': '1', 17:20:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:30 INFO - 'NO_EM_RESTART': '1', 17:20:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:30 INFO - 'PWD': '/builds/slave/test', 17:20:30 INFO - 'SHELL': '/bin/bash', 17:20:30 INFO - 'SHLVL': '1', 17:20:30 INFO - 'TERM': 'linux', 17:20:30 INFO - 'TMOUT': '86400', 17:20:30 INFO - 'USER': 'cltbld', 17:20:30 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1470356198.260135-1506876525', 17:20:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:30 INFO - '_': '/tools/buildbot/bin/python'} 17:20:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:20:30 INFO - Cleaning up... 17:20:30 INFO - Return code: 0 17:20:30 INFO - Running post-action listener: _resource_record_post_action 17:20:30 INFO - Running post-action listener: _start_resource_monitoring 17:20:30 INFO - Starting resource monitoring. 17:20:30 INFO - [mozharness: 2016-08-05 00:20:30.744921Z] Finished create-virtualenv step (success) 17:20:30 INFO - [mozharness: 2016-08-05 00:20:30.745409Z] Running install step. 17:20:30 INFO - Running pre-action listener: _resource_record_pre_action 17:20:30 INFO - Running main action method: install 17:20:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:20:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:20:30 INFO - Reading from file tmpfile_stdout 17:20:30 INFO - Detecting whether we're running mozinstall >=1.0... 17:20:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:20:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:20:31 INFO - Reading from file tmpfile_stdout 17:20:31 INFO - Output received: 17:20:31 INFO - Usage: mozinstall [options] installer 17:20:31 INFO - Options: 17:20:31 INFO - -h, --help show this help message and exit 17:20:31 INFO - -d DEST, --destination=DEST 17:20:31 INFO - Directory to install application into. [default: 17:20:31 INFO - "/builds/slave/test"] 17:20:31 INFO - --app=APP Application being installed. [default: firefox] 17:20:31 INFO - mkdir: /builds/slave/test/build/application 17:20:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:20:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:20:48 INFO - Reading from file tmpfile_stdout 17:20:48 INFO - Output received: 17:20:48 INFO - /builds/slave/test/build/application/firefox/firefox 17:20:48 INFO - Running post-action listener: _resource_record_post_action 17:20:48 INFO - [mozharness: 2016-08-05 00:20:48.313674Z] Finished install step (success) 17:20:48 INFO - [mozharness: 2016-08-05 00:20:48.313925Z] Running run-tests step. 17:20:48 INFO - Running pre-action listener: _resource_record_pre_action 17:20:48 INFO - Running main action method: run_tests 17:20:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:20:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:20:48 INFO - Python 2.7.3 17:20:48 INFO - Return code: 0 17:20:48 INFO - grabbing minidump binary from tooltool 17:20:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:20:48 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 0x19433b0>, '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 0x19442b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1944740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:20:48 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 17:20:48 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 17:20:48 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 17:20:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:20:48 INFO - Return code: 0 17:20:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:20:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:20:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:20:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:20:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:20:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Pbuz5S7lTSu88t5EcIoUmA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 17:20:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Pbuz5S7lTSu88t5EcIoUmA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --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 17:20:48 INFO - Using env: {'DISPLAY': ':0', 17:20:48 INFO - 'HOME': '/home/cltbld', 17:20:48 INFO - 'LANG': 'en_US.UTF-8', 17:20:48 INFO - 'LANGUAGE': 'en_US:en', 17:20:48 INFO - 'LOGNAME': 'cltbld', 17:20:48 INFO - 'MAIL': '/var/mail/cltbld', 17:20:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:20:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:20:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:48 INFO - 'MOZ_NO_REMOTE': '1', 17:20:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:20:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:48 INFO - 'NO_EM_RESTART': '1', 17:20:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:48 INFO - 'PWD': '/builds/slave/test', 17:20:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:20:48 INFO - 'SHELL': '/bin/bash', 17:20:48 INFO - 'SHLVL': '1', 17:20:48 INFO - 'TERM': 'linux', 17:20:48 INFO - 'TMOUT': '86400', 17:20:48 INFO - 'USER': 'cltbld', 17:20:48 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1470356198.260135-1506876525', 17:20:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:48 INFO - '_': '/tools/buildbot/bin/python'} 17:20:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Pbuz5S7lTSu88t5EcIoUmA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 17:20:48 INFO - mozversion application_buildid: 20160804143003 17:20:48 INFO - mozversion application_changeset: c60886d5c003908affbe74e56a7c5b88021b4c6e 17:20:48 INFO - mozversion application_display_name: Nightly 17:20:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:20:48 INFO - mozversion application_name: Firefox 17:20:48 INFO - mozversion application_remotingname: firefox 17:20:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:20:48 INFO - mozversion application_vendor: Mozilla 17:20:48 INFO - mozversion application_version: 51.0a1 17:20:48 INFO - mozversion platform_buildid: 20160804143003 17:20:48 INFO - mozversion platform_changeset: c60886d5c003908affbe74e56a7c5b88021b4c6e 17:20:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:20:48 INFO - mozversion platform_version: 51.0a1 17:20:48 INFO - using testdate: 1470356448 17:20:48 INFO - actual date: 1470356448 17:20:48 INFO - starting webserver on 'localhost:49720' 17:20:48 INFO - SUITE-START | Running 2 tests 17:20:48 INFO - TEST-START | dromaeo_css 17:20:48 INFO - operating with platform_type : linux_ 17:20:48 INFO - Initialising browser for dromaeo_css test... 17:20:48 INFO - TEST-INFO | started process 12340 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDTmpkr/profile http://localhost:49720/getInfo.html) 17:20:52 INFO - PROCESS | 12340 | __metrics Screen width/height:1600/1200 17:20:52 INFO - PROCESS | 12340 | colorDepth:24 17:20:52 INFO - PROCESS | 12340 | Browser inner width/height: 1024/697 17:20:52 INFO - PROCESS | 12340 | __metrics 17:20:53 INFO - PROCESS | 12340 | 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" 17:20:53 INFO - PROCESS | 12340 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:20:53 INFO - PROCESS | 12340 | console.error: PushService: 17:20:53 INFO - PROCESS | 12340 | stateChangeProcessEnqueue: Error transitioning state 17:20:53 INFO - PROCESS | 12340 | UnknownError 17:20:54 INFO - TEST-INFO | 12340: exit 0 17:20:54 INFO - Browser initialized. 17:20:54 INFO - Running cycle 1/1 for dromaeo_css test... 17:20:54 INFO - TEST-INFO | started process 12423 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDTmpkr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:21:06 INFO - PROCESS | 12423 | RSS: Main: 156446720 17:21:06 INFO - PROCESS | 12423 | 17:21:57 INFO - PROCESS | 12423 | 1470356517981 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] 17:24:07 INFO - PROCESS | 12423 | Cycle 1(1): loaded http://localhost:49720/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49720/tests/dromaeo/cssquery-ext.html) 17:24:08 INFO - PROCESS | 12423 | RSS: Main: 261419008 17:24:08 INFO - PROCESS | 12423 | 17:27:10 INFO - PROCESS | 12423 | Cycle 1(1): loaded http://localhost:49720/tests/dromaeo/cssquery-ext.html (next: http://localhost:49720/tests/dromaeo/cssquery-jquery.html) 17:27:11 INFO - PROCESS | 12423 | RSS: Main: 240500736 17:27:11 INFO - PROCESS | 12423 | 17:30:13 INFO - PROCESS | 12423 | Cycle 1(1): loaded http://localhost:49720/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49720/tests/dromaeo/cssquery-mootools.html) 17:30:13 INFO - PROCESS | 12423 | RSS: Main: 213880832 17:30:13 INFO - PROCESS | 12423 | 17:33:15 INFO - PROCESS | 12423 | Cycle 1(1): loaded http://localhost:49720/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49720/tests/dromaeo/cssquery-prototype.html) 17:33:16 INFO - PROCESS | 12423 | RSS: Main: 242294784 17:33:16 INFO - PROCESS | 12423 | 17:36:18 INFO - PROCESS | 12423 | Cycle 1(1): loaded http://localhost:49720/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49720/tests/dromaeo/cssquery-yui.html) 17:36:19 INFO - PROCESS | 12423 | RSS: Main: 186241024 17:36:19 INFO - PROCESS | 12423 | 17:39:22 INFO - PROCESS | 12423 | Cycle 1(1): loaded http://localhost:49720/tests/dromaeo/cssquery-yui.html (next: http://localhost:49720/tests/dromaeo/cssquery-dojo.html) 17:39:22 INFO - PROCESS | 12423 | RSS: Main: 269283328 17:39:22 INFO - PROCESS | 12423 | 17:39:22 INFO - PROCESS | 12423 | __start_tp_report 17:39:22 INFO - PROCESS | 12423 | _x_x_mozilla_page_load 17:39:22 INFO - PROCESS | 12423 | _x_x_mozilla_page_load_details 17:39:22 INFO - PROCESS | 12423 | |i|pagename|runs| 17:39:22 INFO - PROCESS | 12423 | |0;dojo.html;3045.6192975878016;3056.2664960409506;3080.137561482783;3093.95359069614;3094.4275309067816;5179.948200517993;5254.185601231806;5299.33758280215;5310.20346947958;5330.920036199455;5233.267342572033;5276.050310944029;5291.074062039137;5303.496167864047;5305.522502974732;4738.241881299002;4808;4817.4219093708625;4826.155422801014;4921.237208232729;4832.73419961902;4849.636277279218;4875.268709693539;4895.192293271606;4901.995091006353;4737.620990320784;4787.3776409066595;4792.400949881265;4839.709617422948;4858.732769697665;4781.163296423147;4797.136515427222;4798.2802579613335;4869.269609558559;4909;4822.276658501218;4845.927311090337;4849.442314133849;4858.392700912386;4859.028194361142;5095;5193.246979188034;5283.392409872876;5283.867903302448;5299.364076310867;5629.8592535186535;5647.661140331593;5647.802326918538;5688.175214593902;5721.0846264597885;5383.353997520284;5751.137329400582;5761.337446193699;5769.076947688392;5772.249607550992;5217.791288348461;5284.445133261029;5284.497972692588;5346.144616861284;5346.946530534723;5846.239988801429;5852.531797456193;5853.678047707417;5854.121881717691;5870.236869206976;5285.207218917193;5558.277423934944;5601.075822489325;5611.579131565149;5612.663240205601;5574.386817450078;5621.578381621394;5634.014047541746;5702.45826646468;5702.971485142548;5598.048331783607;5635.380108188096;5638;5641.633293835887;5672.035753921843;5598.888022239533;5605.747741351649;5650.63270887391;5652.576056795757;5660.2075709400715;4147.564505726916;4182.832686692559;4186.267403204488;4308.80610372534;4386.868393948187;3858.7298889078056;3876.437916502148;3903.785291808978;3919.412088186795;3949.763014219156;5351.438098999549;5352.464753524617;5356.035913535523;5358.98179345923;5416.647917885325;5394.217838413487;5543.805966791143;5698.430156984268;5722.599418040781;5743.913841292384;5158.09733296679;5172.637915345889;5188.870278243074;5210.739463026909;5222.060029194706;4723.220668589644;4775.474697783241;4776.713397196179;4782.689125206851;4820.204666230103;5551.777928882881;5767.913481297784;5782.942170578324;5787.045137552341;5805.796797112081;5663.980483513007;5706.828795136153;5711.857203569944;5744.368119506935;5760.596758227051;5877.500412464818;5887.8233652990475;5888.293404791452;5897.852553686193;5905.586608937505;5418.945810541844;5486.067368547437;5543.805966791143;5580.358258800127;5598.076317407745;5620.8875822482505;5656.406077361982;5671.376148623731;5700.914486282792;5714.314282286152;5483.122700367922;5525.972370138124;5529.64057336288;5534.225208470737;5537;5363.141897296414;5501.779928802803;5524.585656075891;5538.529225015919;5563.7774489019985;5476.726163691879;5543.251661025871;5552.916706249491;5591.27313449249;5593.356763972195;5605.691686957257;5625.521830644441;5647.29408823897;5648.068068768607;5660.037793575185;5200.843974680765;5246.658967167122;5478.863028424321;5498.257735205696;5507.339119305549 17:39:22 INFO - PROCESS | 12423 | |1;ext.html;574.652335337121;607.1227076873917;608.3946473259108;609.198903441974;634.9682515874205;33027.33945321092;43152.13695726084;43720.56279437205;43757.34363984543;43805.56194438055;45784.77107614466;46293.074138517295;46327.30509042367;46403.30395044077;46443.76778116105;8823.338249631288;8967.237784788269;8968.820623587524;8971.46171229725;8977.865332020025;8737.257333126692;8823.911760882373;8839.29285657146;8841.911580884173;8847.469151850877;8853.291736661084;8901.109889011112;8923.643054277822;8924.46453212806;8939.821203575924;8840.778980525507;8880.067592902782;8886.822263554757;8898.599563019647;8902.955485222597;8745.518996455192;8785.989611194667;8819.073997230327;8827.823443531157;8832.293416526663;43199.784001079795;43323.350149747464;43719.56280437187;43723.781381093206;43797.78101109506;3549.4143466328023;3722.4230244312175;3980.980095099535;4041.717079804415;4448.555144485558;31433.528497072562;33501.376025798556;34148.6585134148;34242.14394640129;34921.47617785735;4349.565043495657;4438.778061096932;4439.422875026258;4540.79566419512;4555.681102322838;345050;351993;352426.99999999744;352525.99999999744;352947;60350;62130;62714;62752;62863.68568157221;67413;67906;67959.66020169966;68009;68025;17087.572810679583;17304.134793260288;17330.046847423513;17335.65328693419;17338;13231.073824832169;13341.132826366254;13379.933100334436;13382.665433364049;13392.598222053353;18593.820595697216;20148.798512014986;20267;20290.69563956542;20360.18559257643;7446.090802328821;7567.356774674105;7568.5837278950185;7679.731209407644;8034.879476807852;898.4448844359167;1079.7192729890285;1103.200179869588;1103.939283339424;1131.7453572946185;31757.523637145463;33071.50392744111;33227.667723322455;33384.66615333864;33450.81864766904;1156.9595064172713;1160.6692092753524;1168.6669299249672;1184.2894263441865;1193.6061099837207;17130.229139688745;17259.654806903793;17327.826721732872;17397.304107835796;17653.293868245128;599112;603153;604815;605349;608065;58787.41212587905;59487;59497.702511487165;59671.403285967455;59721.10418343728;1230.9507619695291;1296.5786119511008;1299.1880074953153;1346.602752188107;1361.0948719101884;30258.697413025588;33506;34292.48561271533;34592;34642.65357346394;52031.219531706294;52827.47172528225;52868;52913;52933.206001910774;523437;532642;532838;535007;535357;35209.47185792266;43956.78021609871;44899;47648;47967;49092.509074910224;49229.50770492249;49230;49324;49420;41522.37716434316;41602.16795664009;42412.64001839411;43200.13599728051;43610.345844811716;41983.790081049396;42292.577074228866;42746.358804618576;42778.35832462453;43153.13693726045;41245.793771030956;42108.789456052524;42182;42448;42664.14671706486;35755.46366804448;37376.439353410264;37571.81214093912;37948.104985308695;38513.80743096267;27303.846230614447;27827;28064.71935280621;28194.43611127807;28327.575086374134 17:39:22 INFO - PROCESS | 12423 | |2;jquery.html;377.47342457272106;380.36858814368156;395.62613330402775;401.17358242021436;417.9331306990882;14480.16709807017;17513.949163050227;18520.073996300183;20052.097655605496;20061.297854575092;15772.526824195293;19115.522111947208;19778.604427911432;19831.305904293316;20094.999999999964;5798.971005144968;5979;5987.341392446828;5990.071538911476;6015.278166620012;5869.178315035899;5931.673757943311;5965.970170149143;5973.671448070354;5974.820755377345;5716.79991200306;5824.126381042856;5872.442117998783;5873.177755114288;5887.058070708687;5880.6765627890445;5906.675132867691;5927.881442371172;5928.347881733006;6914.723411063552;6898.206706228798;7022.543534670282;7149.714011439536;7150.284971502861;7153.177384600785;27323.726762732516;27518.724812752018;27869.58195627067;27974;27977.86011069952;2449.2040086971806;2492.7756501914914;2560.46230291639;2586.547354213024;2650.774684151849;15976.007639358617;16076.839231607652;16354.591135221595;16447;17347.21937512815;1986.7218589397496;2099.95800083999;2113.408245691209;2144.2280778919576;2160.83793715472;81215;87164.12835871623;90951.54524227337;92635.53682231613;99772;18087.276508939758;18209.544761380806;18403.90798046001;18447.631047378978;18476.722849157275;33024.50463243053;33099.50350744741;33107.834460827544;33112.66887331144;33313.333733325686;10064;10121.190304775748;10148.898511014942;10193.184545236363;10443.895561044292;8415.579221039046;8533.74398768038;8546.700865469678;8771.342149338698;8790.560471976503;7482.4388170887405;8540.871886921701;9125.543722813965;9143.54282285883;9180.908190918006;3041.442016588819;3504.8247587620517;3526.7883926964464;3639.836207370675;3646.872359467406;856.9014563325297;947.6114792934864;951.6050838901916;960.5149399553181;1015.4110615842941;19544.12051457688;19894.204231830856;19932.103055362542;20388.184472621226;20686.79313206879;1006.9043440873252;1010.4796030044533;1026.2200727447193;1050.4905121016302;1078.816601177786;10749.731256718489;11161.72095697614;11289.379084150287;11302.265352752045;11312.434378281054;481542;491786;492163;495887;496336;95378;96013.5199324013;96020;96833.03166968381;98066.5096674512;947.5688561704408;975.2295686407658;986.6743974488402;988.6292640259902;996.6461906023258;16313.26590303463;17490.91254543719;18244.90877545604;18665;18728.531786704898;41904.3714344279;46978.53021469741;47195.52804471911;47215.29177062278;48847;61295.38704612897;62921.68539157275;63517;64479.48643595091;65121.67439162774;8610.526421046903;9007.774805629911;9020.503872287087;9064.773380665536;9302.860457093284;10248.59005639796;13842.930785346009;13946.302684865514;14419.567412977627;14610.123392596479;11899.76200476003;11929.28424294545;12030.27818330903;12083.637490875288;12084.274943503418;10945.616903408343;11109.444527773741;11213.71965700864;11486.655400338002;11704.94147529257;11491.828677095173;11684.532618695157;11888.167828252286;12137.817932731192;12327.630171094881;8797.12028797115;8870.955645221991;8908.287337012895;9312.44125352481;9321.067893210897;10893.291936024134;12239.75520489603;12259.141860070065;12334.81497777516;12359.443825028075 17:39:22 INFO - PROCESS | 12423 | |3;mootools.html;1327.1240980952573;1442.8412874583794;1515.3029606381065;1613.370785393696;1755.9297628094869;8446.324294056476;8769.210771030606;8849.646014159442;9136.223421009205;9147.496887671192;8993.100689931003;9096.954515227431;9117.22503587196;9124.22444092253;9124.315676324286;2358.964615530764;2382.845115067515;2384.904603815854;2385.5348207099623;2387.319613910036;2305.4351683837485;2339.6724458575814;2360.834741568091;2366.290112966112;2367.609344458171;2338.83628146029;2358.6815779869758;2369.834111612188;2373.1812524679044;2376.049580167938;2256.954860902773;2284.3832165315357;2291.51878105598;2291.6104262275453;2341.2273949596593;2284.7715228477186;2289.381866895929;2294.8508346957396;2297.5060362022077;2299.655051742235;8929.821403571957;8929.955350223207;9030.819383612292;9082.545872706338;9087.818243635156;5113.51421614946;5288.735563221823;5299.947000529984;5302.628815982883;5309.734513274359;3480.6867381935494;3530.682238598513;3543.663351981583;3583.0325812030605;3587.677109060171;1209.6431552691888;1237.4555195713858;1239.69007748063;1249.7562975219835;1270.5235536673747;12297.692557686129;12308.507659693601;12326.938365308206;12341.568045118378;12394;4284.635805956528;4461.152381047591;4570.611498022706;4578.771061446914;4627.329037289642;9764.072413120743;9766.267529935283;9769.120779129913;9770.36492627977;9772.609095636237;5262.657927234794;5266.657667251693;5267.815626453133;5271.446498117719;5280.339957505312;4057.9797101014306;4310.073334233155;4429.379886815848;4502.527234640381;4896.608271338356;3688.2254726507736;3702.981680037957;3776;3831.540215174197;3842.9039274018373;1125.651048175052;1151.6890439581266;1159.1538177130742;1164.4003338280793;1173.2784337632295;831.4637059096849;844.3667249562828;1002.0780881588955;1004.1213937804421;1026.471367245869;6045.6070355426755;6104.542159338067;6192.783252586228;6221.62670239778;6311.558190926683;977.1059480575336;993.8459538771502;998.5656239535825;1003.1473247739509;1004.5931397783909;4060.451839001756;4141.233871733739;4168.7290326128705;4283.700140990163;4373.300271956536;10847.51186196623;10903.83644245337;10997.505112269968;11160.107191424666;11177.21759476845;11093.168012399103;11104.777904441866;11116.666500005012;11125.221234513507;11133;8292.212239837207;8489.660413583388;8550.315974722007;8553.44402613828;8554.059053504234;6055.878882422238;6096.359882212481;6146.354632763674;6168.074788781719;6311.621302721851;10191.898081019392;10287.742806429898;10507.789844203226;10518.474076296308;10585.259031867696;9425.952870235606;10381.84427233577;10482.161427085968;10751.462426878468;10830.187735919995;8357.456765310235;8450.450720703135;8590.312774978112;8764.298856091626;8770.517621530622;8648.264897483785;8739.519326437106;8742.781430464034;8758.299336053227;8762.07998160184;7463.925360746323;7631.580263085583;7713.652885620048;7745.341645960157;7781.688732450639;7741.419393545394;7762.301392874669;7794.415418843496;7802.921970780447;7903.9209607903185;7186.676599553137;7305.744298949511;7320.63396830167;7364.852702946018;7390.815229619303;5322.654027488201;5407.2970513834525;5434.83695489136;5453.449383958553;5565.16522521625;5230.293910322058;5240.109181439088;5315.6279060465395;5452.318460192476;5509.614326997072 17:39:22 INFO - PROCESS | 12423 | |4;prototype.html;317.365269461078;335.57382124701627;340.14284004309155;341.30203733365266;342.28291728828094;5029.522195391437;5071.695698258102;5143.897122057557;5166.638335316525;5186.559142472895;5116.641835071547;5121.897562048757;5126.5642420394215;5126.92309615356;5141.383034035921;4095.89760255993;4100.815463304143;4111.506619205685;4117.4441450404265;4124.278251306025;4022.365350695299;4085.81613827377;4098.938515922264;4144.544100148996;4152.875413737593;4063.2482990646827;4068.65416439603;4072.857449989251;4086.5300490443533;4090.8772736817796;4075.7350772200007;4077.857274995376;4093.140440507497;4097.97951010243;4109.178164367138;3658.5243918290716;3668.0829792551863;3669.733941790078;3672.8347224374966;3681.852725890961;4814.2558741517;5011.1481048221885;5060.46865079165;5060.78541150125;5066.69599824008;4607.470140933802;4617.884552886205;4621.145088158668;4624.861254162381;4636.907261854778;5247.370315562157;5382.703951282678;5385.219143224211;5401.353336864908;5466.753996070186;3906.867008567512;3921.3529767588316;3941.3890846918775;3941.822617982169;3978.4827972363696;5294.570465974204;5460.989716902386;5592.720363981784;5627.887442251132;5634.859128521779;3850.172212974224;3867.16855875988;3870.1292209253256;3880.1463677990796;3963.7819919904105;3973.245083434196;3996.8800935971967;4003.8398464061693;4020.512410408109;4042.8180731867137;4528.0691545183545;4570.085982803453;4588.325261279676;4592.517785632461;4595.310703394518;5305;5375.435579264121;5398.595105367034;5400.594955378284;5402.594805389612;1374.7387996280675;1394.0868730981224;1396.5321617258332;1396.5461225101678;1397.895157863144;870.5734190246734;906.6101576322113;912;927.5223260021095;932.3147486597345;4522.140793249272;4561.521040290721;4581.587657110809;4596.287575425815;4598.931016034762;4829.6860704054125;4877.6587238125185;4908.803647854117;4912.926306105412;4936.211040761958;4399.780010999501;4574.908501829945;4595.471520775087;4596.897094461226;4615.699979501322;2577.046492797677;2584.5477041518034;2588.352911772057;2588.4564241509115;2606.4005278785608;4984.40187177541;5022.472640372781;5029.748512574357;5034.823781167642;5076.263941728429;4753.762311884392;4951.232558953368;4953.925691114636;4989.625778066659;5015.573676237561;4907.312976183409;4968.478309777493;4984.875378115504;5004.3494345734825;5010.7179797232875;4878.414590249051;4878.536539028786;4879;4891.241857512091;4899.828506002273;4521.321801729635;4819.903601927872;4826.638002149783;4864.756762161948;4908.852734417973;4842.854714358575;4938.901221975469;5444.918326225031;5623.297087864017;5741.224934633938;3902.746321489094;3922.37242041272;3932.488776459042;3943.329633962176;3943.6056394360335;5515;5538.418466061166;5553.361363443256;5558.749856256397;5613.943860561342;5174.249733788504;5330.493603107699;5373.2746079278795;5374.167004114369;5437.184422336682;5356.143017117242;5374.355077390582;5378.247045413567;5383.650062745909;5390.353157620953;5334.599905007218;5346.1713434417725;5346.652467589594;5386.111291636836;5409.350877894678;5160.948390516197;5424.701641409602;5440.292761940922;5494.917576236279;5496.642718223303;5368.382635996754;5369.6509726867625;5375.731213439391;5418.864528386822;5450.5367043801725 17:39:22 INFO - PROCESS | 12423 | |5;yui.html;790.5809920742005;822.1244374740901;825.6037102190952;825.9669613215472;835.8119423129795;15970.281337339818;16365.83634163658;17174.82825171751;17295.913520432397;17305.82694173058;15661.138637374968;15863.92068039661;15874.84125158748;15887.920560397211;15898.364065437368;789.5420656019495;810.8013536683521;812.3785304242259;813.2436833744615;813.8616435206029;654.5679851298145;789.6328207383566;809.8056466448039;810.0401024785648;818.4189225649766;852.2585350744861;852.6887685994599;852.7740148860526;854.5342788180457;855.422589751918;852.6376290076723;853.4580541356283;853.9957300213521;854.2439940652505;854.478767951549;499.42431628213046;588.2059220052937;610.4261993725884;612.2408213814838;612.9080637904306;15201.771973420407;15325.693486130327;15359.923200384039;15395.153266570334;15403;13277.601671949857;13712.17726936377;14505.129692218501;14758.55724328272;14852.2573871306;11807.822882656767;11882.346470944094;11890.405479726065;11928.40357982106;12171.756564868741;4375.606195442394;4418.469783625953;4473.544435123193;4517.412736344254;4547.226971414867;83270;83504;84637;84742.15257847404;84941.57529212315;11560.884391156149;11583.247088939192;11875.40622968848;11953.820692689616;12032.27806331623;22205;22284.442888927908;22295.88852055762;22303.776962230495;22419.10323587071;8748.825023499494;8754.47473151613;8784.297256219486;8906.332025098143;9126.771830704285;4538;4621.607163391082;4630.351750754897;4738.597219236334;4952.083864485082;3459.844307006191;3472.218750781054;3528.947065794015;3535.4520049392386;3562.4656301554974;614.6588643302921;617.4103730937035;625.327772644409;625.3902445116066;627.3350248736263;656.8259411256021;684.8253695307665;697.2748341724651;712.2058904321748;721.271515769077;9624.711258662252;9773.267004974656;9858.162056225301;9870.901290986998;10009.349392289478;567.3107174782659;637.7321524959528;657.9539432239793;660.379243511098;661.4258065803454;4417.845375411845;4706.882327941828;4711.4193708199155;4719;4790.712557246507;124748.01351903746;130922;132815;134375;136451;107508;108418;110544;110654;113493.43253283846;58227.12659310114;73398;83647.58176209201;84245.99999999878;87394;9733.415995040321;10312.845307320546;10467.476626168813;10521.105706015074;10688.412137332522;52515;52834.73582632062;53528.732356339526;53814.19278710901;53910.46089539054;74773;77014.61492692724;79571.60214199123;79757;82703.5864820672;12730.87269127334;13202.537911173447;13384.263865487103;13498.797518037041;13618.863811362156;15257.694846103237;15404.614884627974;15431.196388485643;15447;15531.758195823979;14063.578092657237;14078.366473508511;14296.57110286693;14484.203368814817;14986.550403487912;12769.872301276868;12960.287184204959;13335.66660833487;13439.46242150303;13750.174989500661;13900.582982510541;13972.860271397563;13985.790213146607;14062.859371406155;14071.226082565558;11278.266912650652;11537.826932596186;11739.823902641296;11912;12220.4139956736;10855.782884342427;11388.14588905852;11399.943000284946;11491;11500.884991149982 17:39:22 INFO - PROCESS | 12423 | __end_tp_report 17:39:22 INFO - PROCESS | 12423 | __start_cc_report 17:39:22 INFO - PROCESS | 12423 | _x_x_mozilla_cycle_collect,1002 17:39:22 INFO - PROCESS | 12423 | __end_cc_report 17:39:22 INFO - PROCESS | 12423 | __startTimestamp1470357562711__endTimestamp 17:39:22 INFO - PROCESS | 12423 | 17:39:22 INFO - PROCESS | 12423 | ------- Summary: start ------- 17:39:22 INFO - PROCESS | 12423 | Number of tests: 6 17:39:22 INFO - PROCESS | 12423 | 17:39:22 INFO - PROCESS | 12423 | [#0] dojo.html Cycles:165 Average:5249.49 Median:5476.73 stddev:598.18 (10.9%) stddev-sans-first:574.49 17:39:22 INFO - PROCESS | 12423 | Values: 3045.6 3056.3 3080.1 3094.0 3094.4 5179.9 5254.2 5299.3 5310.2 5330.9 5233.3 5276.1 5291.1 5303.5 5305.5 4738.2 4808.0 4817.4 4826.2 4921.2 4832.7 4849.6 4875.3 4895.2 4902.0 4737.6 4787.4 4792.4 4839.7 4858.7 4781.2 4797.1 4798.3 4869.3 4909.0 4822.3 4845.9 4849.4 4858.4 4859.0 5095.0 5193.2 5283.4 5283.9 5299.4 5629.9 5647.7 5647.8 5688.2 5721.1 5383.4 5751.1 5761.3 5769.1 5772.2 5217.8 5284.4 5284.5 5346.1 5346.9 5846.2 5852.5 5853.7 5854.1 5870.2 5285.2 5558.3 5601.1 5611.6 5612.7 5574.4 5621.6 5634.0 5702.5 5703.0 5598.0 5635.4 5638.0 5641.6 5672.0 5598.9 5605.7 5650.6 5652.6 5660.2 4147.6 4182.8 4186.3 4308.8 4386.9 3858.7 3876.4 3903.8 3919.4 3949.8 5351.4 5352.5 5356.0 5359.0 5416.6 5394.2 5543.8 5698.4 5722.6 5743.9 5158.1 5172.6 5188.9 5210.7 5222.1 4723.2 4775.5 4776.7 4782.7 4820.2 5551.8 5767.9 5782.9 5787.0 5805.8 5664.0 5706.8 5711.9 5744.4 5760.6 5877.5 5887.8 5888.3 5897.9 5905.6 5418.9 5486.1 5543.8 5580.4 5598.1 5620.9 5656.4 5671.4 5700.9 5714.3 5483.1 5526.0 5529.6 5534.2 5537.0 5363.1 5501.8 5524.6 5538.5 5563.8 5476.7 5543.3 5552.9 5591.3 5593.4 5605.7 5625.5 5647.3 5648.1 5660.0 5200.8 5246.7 5478.9 5498.3 5507.3 17:39:22 INFO - PROCESS | 12423 | 17:39:22 INFO - PROCESS | 12423 | [#1] ext.html Cycles:180 Average:66076.25 Median:43722.17 stddev:134888.90 (308.5%) stddev-sans-first:135177.65 17:39:22 INFO - PROCESS | 12423 | Values: 574.7 607.1 608.4 609.2 635.0 33027.3 43152.1 43720.6 43757.3 43805.6 45784.8 46293.1 46327.3 46403.3 46443.8 8823.3 8967.2 8968.8 8971.5 8977.9 8737.3 8823.9 8839.3 8841.9 8847.5 8853.3 8901.1 8923.6 8924.5 8939.8 8840.8 8880.1 8886.8 8898.6 8903.0 8745.5 8786.0 8819.1 8827.8 8832.3 43199.8 43323.4 43719.6 43723.8 43797.8 3549.4 3722.4 3981.0 4041.7 4448.6 31433.5 33501.4 34148.7 34242.1 34921.5 4349.6 4438.8 4439.4 4540.8 4555.7 345050.0 351993.0 352427.0 352526.0 352947.0 60350.0 62130.0 62714.0 62752.0 62863.7 67413.0 67906.0 67959.7 68009.0 68025.0 17087.6 17304.1 17330.0 17335.7 17338.0 13231.1 13341.1 13379.9 13382.7 13392.6 18593.8 20148.8 20267.0 20290.7 20360.2 7446.1 7567.4 7568.6 7679.7 8034.9 898.4 1079.7 1103.2 1103.9 1131.7 31757.5 33071.5 33227.7 33384.7 33450.8 1157.0 1160.7 1168.7 1184.3 1193.6 17130.2 17259.7 17327.8 17397.3 17653.3 599112.0 603153.0 604815.0 605349.0 608065.0 58787.4 59487.0 59497.7 59671.4 59721.1 1231.0 1296.6 1299.2 1346.6 1361.1 30258.7 33506.0 34292.5 34592.0 34642.7 52031.2 52827.5 52868.0 52913.0 52933.2 523437.0 532642.0 532838.0 535007.0 535357.0 35209.5 43956.8 44899.0 47648.0 47967.0 49092.5 49229.5 49230.0 49324.0 49420.0 41522.4 41602.2 42412.6 43200.1 43610.3 41983.8 42292.6 42746.4 42778.4 43153.1 41245.8 42108.8 42182.0 42448.0 42664.1 35755.5 37376.4 37571.8 37948.1 38513.8 27303.8 27827.0 28064.7 28194.4 28327.6 17:39:22 INFO - PROCESS | 12423 | 17:39:22 INFO - PROCESS | 12423 | [#2] jquery.html Cycles:180 Average:31073.17 Median:33213.00 stddev:81187.49 (244.4%) stddev-sans-first:81382.52 17:39:22 INFO - PROCESS | 12423 | Values: 377.5 380.4 395.6 401.2 417.9 14480.2 17513.9 18520.1 20052.1 20061.3 15772.5 19115.5 19778.6 19831.3 20095.0 5799.0 5979.0 5987.3 5990.1 6015.3 5869.2 5931.7 5966.0 5973.7 5974.8 5716.8 5824.1 5872.4 5873.2 5887.1 5880.7 5906.7 5927.9 5928.3 6914.7 6898.2 7022.5 7149.7 7150.3 7153.2 27323.7 27518.7 27869.6 27974.0 27977.9 2449.2 2492.8 2560.5 2586.5 2650.8 15976.0 16076.8 16354.6 16447.0 17347.2 1986.7 2100.0 2113.4 2144.2 2160.8 81215.0 87164.1 90951.5 92635.5 99772.0 18087.3 18209.5 18403.9 18447.6 18476.7 33024.5 33099.5 33107.8 33112.7 33313.3 10064.0 10121.2 10148.9 10193.2 10443.9 8415.6 8533.7 8546.7 8771.3 8790.6 7482.4 8540.9 9125.5 9143.5 9180.9 3041.4 3504.8 3526.8 3639.8 3646.9 856.9 947.6 951.6 960.5 1015.4 19544.1 19894.2 19932.1 20388.2 20686.8 1006.9 1010.5 1026.2 1050.5 1078.8 10749.7 11161.7 11289.4 11302.3 11312.4 481542.0 491786.0 492163.0 495887.0 496336.0 95378.0 96013.5 96020.0 96833.0 98066.5 947.6 975.2 986.7 988.6 996.6 16313.3 17490.9 18244.9 18665.0 18728.5 41904.4 46978.5 47195.5 47215.3 48847.0 61295.4 62921.7 63517.0 64479.5 65121.7 8610.5 9007.8 9020.5 9064.8 9302.9 10248.6 13842.9 13946.3 14419.6 14610.1 11899.8 11929.3 12030.3 12083.6 12084.3 10945.6 11109.4 11213.7 11486.7 11704.9 11491.8 11684.5 11888.2 12137.8 12327.6 8797.1 8871.0 8908.3 9312.4 9321.1 10893.3 12239.8 12259.1 12334.8 12359.4 17:39:22 INFO - PROCESS | 12423 | 17:39:22 INFO - PROCESS | 12423 | [#3] mootools.html Cycles:180 Average:5895.58 Median:4574.69 stddev:3359.77 (73.4%) stddev-sans-first:3351.65 17:39:22 INFO - PROCESS | 12423 | Values: 1327.1 1442.8 1515.3 1613.4 1755.9 8446.3 8769.2 8849.6 9136.2 9147.5 8993.1 9097.0 9117.2 9124.2 9124.3 2359.0 2382.8 2384.9 2385.5 2387.3 2305.4 2339.7 2360.8 2366.3 2367.6 2338.8 2358.7 2369.8 2373.2 2376.0 2257.0 2284.4 2291.5 2291.6 2341.2 2284.8 2289.4 2294.9 2297.5 2299.7 8929.8 8930.0 9030.8 9082.5 9087.8 5113.5 5288.7 5299.9 5302.6 5309.7 3480.7 3530.7 3543.7 3583.0 3587.7 1209.6 1237.5 1239.7 1249.8 1270.5 12297.7 12308.5 12326.9 12341.6 12394.0 4284.6 4461.2 4570.6 4578.8 4627.3 9764.1 9766.3 9769.1 9770.4 9772.6 5262.7 5266.7 5267.8 5271.4 5280.3 4058.0 4310.1 4429.4 4502.5 4896.6 3688.2 3703.0 3776.0 3831.5 3842.9 1125.7 1151.7 1159.2 1164.4 1173.3 831.5 844.4 1002.1 1004.1 1026.5 6045.6 6104.5 6192.8 6221.6 6311.6 977.1 993.8 998.6 1003.1 1004.6 4060.5 4141.2 4168.7 4283.7 4373.3 10847.5 10903.8 10997.5 11160.1 11177.2 11093.2 11104.8 11116.7 11125.2 11133.0 8292.2 8489.7 8550.3 8553.4 8554.1 6055.9 6096.4 6146.4 6168.1 6311.6 10191.9 10287.7 10507.8 10518.5 10585.3 9426.0 10381.8 10482.2 10751.5 10830.2 8357.5 8450.5 8590.3 8764.3 8770.5 8648.3 8739.5 8742.8 8758.3 8762.1 7463.9 7631.6 7713.7 7745.3 7781.7 7741.4 7762.3 7794.4 7802.9 7903.9 7186.7 7305.7 7320.6 7364.9 7390.8 5322.7 5407.3 5434.8 5453.4 5565.2 5230.3 5240.1 5315.6 5452.3 5509.6 17:39:22 INFO - PROCESS | 12423 | 17:39:22 INFO - PROCESS | 12423 | [#4] prototype.html Cycles:180 Average:4392.83 Median:4878.77 stddev:1254.29 (25.7%) stddev-sans-first:1219.94 17:39:22 INFO - PROCESS | 12423 | Values: 317.4 335.6 340.1 341.3 342.3 5029.5 5071.7 5143.9 5166.6 5186.6 5116.6 5121.9 5126.6 5126.9 5141.4 4095.9 4100.8 4111.5 4117.4 4124.3 4022.4 4085.8 4098.9 4144.5 4152.9 4063.2 4068.7 4072.9 4086.5 4090.9 4075.7 4077.9 4093.1 4098.0 4109.2 3658.5 3668.1 3669.7 3672.8 3681.9 4814.3 5011.1 5060.5 5060.8 5066.7 4607.5 4617.9 4621.1 4624.9 4636.9 5247.4 5382.7 5385.2 5401.4 5466.8 3906.9 3921.4 3941.4 3941.8 3978.5 5294.6 5461.0 5592.7 5627.9 5634.9 3850.2 3867.2 3870.1 3880.1 3963.8 3973.2 3996.9 4003.8 4020.5 4042.8 4528.1 4570.1 4588.3 4592.5 4595.3 5305.0 5375.4 5398.6 5400.6 5402.6 1374.7 1394.1 1396.5 1396.5 1397.9 870.6 906.6 912.0 927.5 932.3 4522.1 4561.5 4581.6 4596.3 4598.9 4829.7 4877.7 4908.8 4912.9 4936.2 4399.8 4574.9 4595.5 4596.9 4615.7 2577.0 2584.5 2588.4 2588.5 2606.4 4984.4 5022.5 5029.7 5034.8 5076.3 4753.8 4951.2 4953.9 4989.6 5015.6 4907.3 4968.5 4984.9 5004.3 5010.7 4878.4 4878.5 4879.0 4891.2 4899.8 4521.3 4819.9 4826.6 4864.8 4908.9 4842.9 4938.9 5444.9 5623.3 5741.2 3902.7 3922.4 3932.5 3943.3 3943.6 5515.0 5538.4 5553.4 5558.7 5613.9 5174.2 5330.5 5373.3 5374.2 5437.2 5356.1 5374.4 5378.2 5383.7 5390.4 5334.6 5346.2 5346.7 5386.1 5409.4 5160.9 5424.7 5440.3 5494.9 5496.6 5368.4 5369.7 5375.7 5418.9 5450.5 17:39:22 INFO - PROCESS | 12423 | 17:39:22 INFO - PROCESS | 12423 | [#5] yui.html Cycles:180 Average:21954.34 Median:4396.73 stddev:32496.99 (739.1%) stddev-sans-first:32549.29 17:39:22 INFO - PROCESS | 12423 | Values: 790.6 822.1 825.6 826.0 835.8 15970.3 16365.8 17174.8 17295.9 17305.8 15661.1 15863.9 15874.8 15887.9 15898.4 789.5 810.8 812.4 813.2 813.9 654.6 789.6 809.8 810.0 818.4 852.3 852.7 852.8 854.5 855.4 852.6 853.5 854.0 854.2 854.5 499.4 588.2 610.4 612.2 612.9 15201.8 15325.7 15359.9 15395.2 15403.0 13277.6 13712.2 14505.1 14758.6 14852.3 11807.8 11882.3 11890.4 11928.4 12171.8 4375.6 4418.5 4473.5 4517.4 4547.2 83270.0 83504.0 84637.0 84742.2 84941.6 11560.9 11583.2 11875.4 11953.8 12032.3 22205.0 22284.4 22295.9 22303.8 22419.1 8748.8 8754.5 8784.3 8906.3 9126.8 4538.0 4621.6 4630.4 4738.6 4952.1 3459.8 3472.2 3528.9 3535.5 3562.5 614.7 617.4 625.3 625.4 627.3 656.8 684.8 697.3 712.2 721.3 9624.7 9773.3 9858.2 9870.9 10009.3 567.3 637.7 658.0 660.4 661.4 4417.8 4706.9 4711.4 4719.0 4790.7 124748.0 130922.0 132815.0 134375.0 136451.0 107508.0 108418.0 110544.0 110654.0 113493.4 58227.1 73398.0 83647.6 84246.0 87394.0 9733.4 10312.8 10467.5 10521.1 10688.4 52515.0 52834.7 53528.7 53814.2 53910.5 74773.0 77014.6 79571.6 79757.0 82703.6 12730.9 13202.5 13384.3 13498.8 13618.9 15257.7 15404.6 15431.2 15447.0 15531.8 14063.6 14078.4 14296.6 14484.2 14986.6 12769.9 12960.3 13335.7 13439.5 13750.2 13900.6 13972.9 13985.8 14062.9 14071.2 11278.3 11537.8 11739.8 11912.0 12220.4 10855.8 11388.1 11399.9 11491.0 11500.9 17:39:22 INFO - PROCESS | 12423 | -------- Summary: end -------- 17:39:22 INFO - PROCESS | 12423 | 17:39:23 INFO - TEST-INFO | 12423: exit 0 17:39:23 INFO - TEST-OK | dromaeo_css | took 1114864ms 17:39:23 INFO - TEST-START | kraken 17:39:23 INFO - operating with platform_type : linux_ 17:39:23 INFO - Initialising browser for kraken test... 17:39:23 INFO - TEST-INFO | started process 12615 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1o6qCR/profile http://localhost:49720/getInfo.html) 17:39:27 INFO - PROCESS | 12615 | __metrics Screen width/height:1600/1200 17:39:27 INFO - PROCESS | 12615 | colorDepth:24 17:39:27 INFO - PROCESS | 12615 | Browser inner width/height: 1024/697 17:39:27 INFO - PROCESS | 12615 | __metrics 17:39:28 INFO - PROCESS | 12615 | 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" 17:39:28 INFO - PROCESS | 12615 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:39:28 INFO - PROCESS | 12615 | console.error: PushService: 17:39:28 INFO - PROCESS | 12615 | stateChangeProcessEnqueue: Error transitioning state 17:39:28 INFO - PROCESS | 12615 | UnknownError 17:39:29 INFO - TEST-INFO | 12615: exit 0 17:39:29 INFO - Browser initialized. 17:39:29 INFO - Running cycle 1/1 for kraken test... 17:39:29 INFO - TEST-INFO | started process 12694 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1o6qCR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:39:41 INFO - PROCESS | 12694 | RSS: Main: 156176384 17:39:41 INFO - PROCESS | 12694 | 17:39:43 INFO - PROCESS | 12694 | Cycle 1(1): loaded http://localhost:49720/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49720/tests/kraken/driver.html?testName=audio-beat-detection) 17:39:44 INFO - PROCESS | 12694 | RSS: Main: 212955136 17:39:44 INFO - PROCESS | 12694 | 17:39:47 INFO - PROCESS | 12694 | Cycle 1(1): loaded http://localhost:49720/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49720/tests/kraken/driver.html?testName=audio-dft) 17:39:47 INFO - PROCESS | 12694 | RSS: Main: 192081920 17:39:47 INFO - PROCESS | 12694 | 17:39:50 INFO - PROCESS | 12694 | Cycle 1(1): loaded http://localhost:49720/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49720/tests/kraken/driver.html?testName=audio-fft) 17:39:51 INFO - PROCESS | 12694 | RSS: Main: 268935168 17:39:51 INFO - PROCESS | 12694 | 17:39:53 INFO - PROCESS | 12694 | Cycle 1(1): loaded http://localhost:49720/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49720/tests/kraken/driver.html?testName=audio-oscillator) 17:39:53 INFO - PROCESS | 12694 | RSS: Main: 179834880 17:39:53 INFO - PROCESS | 12694 | 17:39:55 INFO - PROCESS | 12694 | Cycle 1(1): loaded http://localhost:49720/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49720/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:39:56 INFO - PROCESS | 12694 | RSS: Main: 184524800 17:39:56 INFO - PROCESS | 12694 | 17:39:59 INFO - PROCESS | 12694 | Cycle 1(1): loaded http://localhost:49720/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49720/tests/kraken/driver.html?testName=imaging-darkroom) 17:40:00 INFO - PROCESS | 12694 | RSS: Main: 220815360 17:40:00 INFO - PROCESS | 12694 | 17:40:03 INFO - PROCESS | 12694 | Cycle 1(1): loaded http://localhost:49720/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49720/tests/kraken/driver.html?testName=imaging-desaturate) 17:40:04 INFO - PROCESS | 12694 | RSS: Main: 220241920 17:40:04 INFO - PROCESS | 12694 | 17:40:06 INFO - PROCESS | 12694 | Cycle 1(1): loaded http://localhost:49720/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49720/tests/kraken/driver.html?testName=json-parse-financial) 17:40:07 INFO - PROCESS | 12694 | RSS: Main: 219934720 17:40:07 INFO - PROCESS | 12694 | 17:40:09 INFO - PROCESS | 12694 | Cycle 1(1): loaded http://localhost:49720/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49720/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:40:09 INFO - PROCESS | 12694 | RSS: Main: 184606720 17:40:09 INFO - PROCESS | 12694 | 17:40:11 INFO - PROCESS | 12694 | Cycle 1(1): loaded http://localhost:49720/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49720/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:40:11 INFO - PROCESS | 12694 | RSS: Main: 189923328 17:40:11 INFO - PROCESS | 12694 | 17:40:13 INFO - PROCESS | 12694 | Cycle 1(1): loaded http://localhost:49720/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49720/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:40:14 INFO - PROCESS | 12694 | RSS: Main: 194621440 17:40:14 INFO - PROCESS | 12694 | 17:40:17 INFO - PROCESS | 12694 | Cycle 1(1): loaded http://localhost:49720/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49720/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:40:17 INFO - PROCESS | 12694 | RSS: Main: 189267968 17:40:17 INFO - PROCESS | 12694 | 17:40:20 INFO - PROCESS | 12694 | Cycle 1(1): loaded http://localhost:49720/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49720/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:40:21 INFO - PROCESS | 12694 | RSS: Main: 193310720 17:40:21 INFO - PROCESS | 12694 | 17:40:22 INFO - PROCESS | 12694 | Cycle 1(1): loaded http://localhost:49720/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49720/tests/kraken/driver.html?testName=ai-astar) 17:40:22 INFO - PROCESS | 12694 | RSS: Main: 243691520 17:40:22 INFO - PROCESS | 12694 | 17:40:22 INFO - PROCESS | 12694 | __start_tp_report 17:40:22 INFO - PROCESS | 12694 | _x_x_mozilla_page_load 17:40:22 INFO - PROCESS | 12694 | _x_x_mozilla_page_load_details 17:40:22 INFO - PROCESS | 12694 | |i|pagename|runs| 17:40:22 INFO - PROCESS | 12694 | |0;ai-astar;101;112;112;110;111;111;111;111;111;111 17:40:22 INFO - PROCESS | 12694 | |1;audio-beat-detection;144;118;121;173;118;118;139;120;163;118 17:40:22 INFO - PROCESS | 12694 | |2;audio-dft;159;159;160;159;160;161;160;161;161;160 17:40:22 INFO - PROCESS | 12694 | |3;audio-fft;73;75;75;127;75;76;73;74;111;76 17:40:22 INFO - PROCESS | 12694 | |4;audio-oscillator;84;83;128;83;82;84;119;84;84;132 17:40:22 INFO - PROCESS | 12694 | |5;imaging-gaussian-blur;116;117;117;118;117;117;117;116;117;116 17:40:22 INFO - PROCESS | 12694 | |6;imaging-darkroom;146;146;146;146;146;145;146;146;146;146 17:40:22 INFO - PROCESS | 12694 | |7;imaging-desaturate;95;95;95;94;95;95;94;94;95;94 17:40:22 INFO - PROCESS | 12694 | |8;json-parse-financial;50;53;51;52;52;52;49;51;51;51 17:40:22 INFO - PROCESS | 12694 | |9;json-stringify-tinderbox;60;60;62;61;62;61;60;61;61;61 17:40:22 INFO - PROCESS | 12694 | |10;stanford-crypto-aes;77;77;76;76;76;86;79;76;76;74 17:40:22 INFO - PROCESS | 12694 | |11;stanford-crypto-ccm;131;123;123;124;127;122;136;121;153;131 17:40:22 INFO - PROCESS | 12694 | |12;stanford-crypto-pbkdf2;157;165;162;161;159;161;160;158;159;155 17:40:22 INFO - PROCESS | 12694 | |13;stanford-crypto-sha256-iterative;64;63;64;63;64;64;63;62;62;62 17:40:22 INFO - PROCESS | 12694 | __end_tp_report 17:40:22 INFO - PROCESS | 12694 | __start_cc_report 17:40:22 INFO - PROCESS | 12694 | _x_x_mozilla_cycle_collect,1659 17:40:22 INFO - PROCESS | 12694 | __end_cc_report 17:40:22 INFO - PROCESS | 12694 | __startTimestamp1470357622983__endTimestamp 17:40:22 INFO - PROCESS | 12694 | 17:40:22 INFO - PROCESS | 12694 | ------- Summary: start ------- 17:40:22 INFO - PROCESS | 12694 | Number of tests: 14 17:40:22 INFO - PROCESS | 12694 | 17:40:22 INFO - PROCESS | 12694 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:3.25 (2.9%) stddev-sans-first:0.60 17:40:22 INFO - PROCESS | 12694 | Values: 101.0 112.0 112.0 110.0 111.0 111.0 111.0 111.0 111.0 111.0 17:40:22 INFO - PROCESS | 12694 | 17:40:22 INFO - PROCESS | 12694 | [#1] audio-beat-detection Cycles:10 Average:133.20 Median:130.00 stddev:20.74 (16.0%) stddev-sans-first:21.62 17:40:22 INFO - PROCESS | 12694 | Values: 144.0 118.0 121.0 173.0 118.0 118.0 139.0 120.0 163.0 118.0 17:40:22 INFO - PROCESS | 12694 | 17:40:22 INFO - PROCESS | 12694 | [#2] audio-dft Cycles:10 Average:160.00 Median:160.00 stddev:0.82 (0.5%) stddev-sans-first:0.78 17:40:22 INFO - PROCESS | 12694 | Values: 159.0 159.0 160.0 159.0 160.0 161.0 160.0 161.0 161.0 160.0 17:40:22 INFO - PROCESS | 12694 | 17:40:22 INFO - PROCESS | 12694 | [#3] audio-fft Cycles:10 Average:83.50 Median:75.00 stddev:19.12 (25.5%) stddev-sans-first:19.89 17:40:22 INFO - PROCESS | 12694 | Values: 73.0 75.0 75.0 127.0 75.0 76.0 73.0 74.0 111.0 76.0 17:40:22 INFO - PROCESS | 12694 | 17:40:22 INFO - PROCESS | 12694 | [#4] audio-oscillator Cycles:10 Average:96.30 Median:83.50 stddev:20.97 (25.1%) stddev-sans-first:21.77 17:40:22 INFO - PROCESS | 12694 | Values: 84.0 83.0 128.0 83.0 82.0 84.0 119.0 84.0 84.0 132.0 17:40:22 INFO - PROCESS | 12694 | 17:40:22 INFO - PROCESS | 12694 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 17:40:22 INFO - PROCESS | 12694 | Values: 116.0 117.0 117.0 118.0 117.0 117.0 117.0 116.0 117.0 116.0 17:40:22 INFO - PROCESS | 12694 | 17:40:22 INFO - PROCESS | 12694 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 17:40:22 INFO - PROCESS | 12694 | Values: 146.0 146.0 146.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 17:40:22 INFO - PROCESS | 12694 | 17:40:22 INFO - PROCESS | 12694 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 17:40:22 INFO - PROCESS | 12694 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 94.0 94.0 95.0 94.0 17:40:22 INFO - PROCESS | 12694 | 17:40:22 INFO - PROCESS | 12694 | [#8] json-parse-financial Cycles:10 Average:51.20 Median:51.50 stddev:1.14 (2.2%) stddev-sans-first:1.12 17:40:22 INFO - PROCESS | 12694 | Values: 50.0 53.0 51.0 52.0 52.0 52.0 49.0 51.0 51.0 51.0 17:40:22 INFO - PROCESS | 12694 | 17:40:22 INFO - PROCESS | 12694 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 17:40:23 INFO - PROCESS | 12694 | Values: 60.0 60.0 62.0 61.0 62.0 61.0 60.0 61.0 61.0 61.0 17:40:23 INFO - PROCESS | 12694 | 17:40:23 INFO - PROCESS | 12694 | [#10] stanford-crypto-aes Cycles:10 Average:77.30 Median:76.50 stddev:3.30 (4.3%) stddev-sans-first:3.50 17:40:23 INFO - PROCESS | 12694 | Values: 77.0 77.0 76.0 76.0 76.0 86.0 79.0 76.0 76.0 74.0 17:40:23 INFO - PROCESS | 12694 | 17:40:23 INFO - PROCESS | 12694 | [#11] stanford-crypto-ccm Cycles:10 Average:129.10 Median:129.00 stddev:9.70 (7.5%) stddev-sans-first:10.26 17:40:23 INFO - PROCESS | 12694 | Values: 131.0 123.0 123.0 124.0 127.0 122.0 136.0 121.0 153.0 131.0 17:40:23 INFO - PROCESS | 12694 | 17:40:23 INFO - PROCESS | 12694 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.70 Median:160.50 stddev:2.79 (1.7%) stddev-sans-first:2.78 17:40:23 INFO - PROCESS | 12694 | Values: 157.0 165.0 162.0 161.0 159.0 161.0 160.0 158.0 159.0 155.0 17:40:23 INFO - PROCESS | 12694 | 17:40:23 INFO - PROCESS | 12694 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:63.50 stddev:0.88 (1.4%) stddev-sans-first:0.87 17:40:23 INFO - PROCESS | 12694 | Values: 64.0 63.0 64.0 63.0 64.0 64.0 63.0 62.0 62.0 62.0 17:40:23 INFO - PROCESS | 12694 | -------- Summary: end -------- 17:40:23 INFO - PROCESS | 12694 | 17:40:23 INFO - TEST-INFO | 12694: exit 0 17:40:24 INFO - TEST-OK | kraken | took 60594ms 17:40:24 INFO - SUITE-END | took 1175s 17:40:24 INFO - Completed test suite (00:19:35) 17:40:24 INFO - javascript benchmark 17:40:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3045.6192975878016, 3056.2664960409506, 3080.137561482783, 3093.95359069614, 3094.4275309067816, 5179.948200517993, 5254.185601231806, 5299.33758280215, 5310.20346947958, 5330.920036199455, 5233.267342572033, 5276.050310944029, 5291.074062039137, 5303.496167864047, 5305.522502974732, 4738.241881299002, 4808.0, 4817.4219093708625, 4826.155422801014, 4921.237208232729, 4832.73419961902, 4849.636277279218, 4875.268709693539, 4895.192293271606, 4901.995091006353, 4737.620990320784, 4787.3776409066595, 4792.400949881265, 4839.709617422948, 4858.732769697665, 4781.163296423147, 4797.136515427222, 4798.2802579613335, 4869.269609558559, 4909.0, 4822.276658501218, 4845.927311090337, 4849.442314133849, 4858.392700912386, 4859.028194361142, 5095.0, 5193.246979188034, 5283.392409872876, 5283.867903302448, 5299.364076310867, 5629.8592535186535, 5647.661140331593, 5647.802326918538, 5688.175214593902, 5721.0846264597885, 5383.353997520284, 5751.137329400582, 5761.337446193699, 5769.076947688392, 5772.249607550992, 5217.791288348461, 5284.445133261029, 5284.497972692588, 5346.144616861284, 5346.946530534723, 5846.239988801429, 5852.531797456193, 5853.678047707417, 5854.121881717691, 5870.236869206976, 5285.207218917193, 5558.277423934944, 5601.075822489325, 5611.579131565149, 5612.663240205601, 5574.386817450078, 5621.578381621394, 5634.014047541746, 5702.45826646468, 5702.971485142548, 5598.048331783607, 5635.380108188096, 5638.0, 5641.633293835887, 5672.035753921843, 5598.888022239533, 5605.747741351649, 5650.63270887391, 5652.576056795757, 5660.2075709400715, 4147.564505726916, 4182.832686692559, 4186.267403204488, 4308.80610372534, 4386.868393948187, 3858.7298889078056, 3876.437916502148, 3903.785291808978, 3919.412088186795, 3949.763014219156, 5351.438098999549, 5352.464753524617, 5356.035913535523, 5358.98179345923, 5416.647917885325, 5394.217838413487, 5543.805966791143, 5698.430156984268, 5722.599418040781, 5743.913841292384, 5158.09733296679, 5172.637915345889, 5188.870278243074, 5210.739463026909, 5222.060029194706, 4723.220668589644, 4775.474697783241, 4776.713397196179, 4782.689125206851, 4820.204666230103, 5551.777928882881, 5767.913481297784, 5782.942170578324, 5787.045137552341, 5805.796797112081, 5663.980483513007, 5706.828795136153, 5711.857203569944, 5744.368119506935, 5760.596758227051, 5877.500412464818, 5887.8233652990475, 5888.293404791452, 5897.852553686193, 5905.586608937505, 5418.945810541844, 5486.067368547437, 5543.805966791143, 5580.358258800127, 5598.076317407745, 5620.8875822482505, 5656.406077361982, 5671.376148623731, 5700.914486282792, 5714.314282286152, 5483.122700367922, 5525.972370138124, 5529.64057336288, 5534.225208470737, 5537.0, 5363.141897296414, 5501.779928802803, 5524.585656075891, 5538.529225015919, 5563.7774489019985, 5476.726163691879, 5543.251661025871, 5552.916706249491, 5591.27313449249, 5593.356763972195, 5605.691686957257, 5625.521830644441, 5647.29408823897, 5648.068068768607, 5660.037793575185, 5200.843974680765, 5246.658967167122, 5478.863028424321, 5498.257735205696, 5507.339119305549], "value": 5209.344711443337, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.652335337121, 607.1227076873917, 608.3946473259108, 609.198903441974, 634.9682515874205, 33027.33945321092, 43152.13695726084, 43720.56279437205, 43757.34363984543, 43805.56194438055, 45784.77107614466, 46293.074138517295, 46327.30509042367, 46403.30395044077, 46443.76778116105, 8823.338249631288, 8967.237784788269, 8968.820623587524, 8971.46171229725, 8977.865332020025, 8737.257333126692, 8823.911760882373, 8839.29285657146, 8841.911580884173, 8847.469151850877, 8853.291736661084, 8901.109889011112, 8923.643054277822, 8924.46453212806, 8939.821203575924, 8840.778980525507, 8880.067592902782, 8886.822263554757, 8898.599563019647, 8902.955485222597, 8745.518996455192, 8785.989611194667, 8819.073997230327, 8827.823443531157, 8832.293416526663, 43199.784001079795, 43323.350149747464, 43719.56280437187, 43723.781381093206, 43797.78101109506, 3549.4143466328023, 3722.4230244312175, 3980.980095099535, 4041.717079804415, 4448.555144485558, 31433.528497072562, 33501.376025798556, 34148.6585134148, 34242.14394640129, 34921.47617785735, 4349.565043495657, 4438.778061096932, 4439.422875026258, 4540.79566419512, 4555.681102322838, 345050.0, 351993.0, 352426.99999999744, 352525.99999999744, 352947.0, 60350.0, 62130.0, 62714.0, 62752.0, 62863.68568157221, 67413.0, 67906.0, 67959.66020169966, 68009.0, 68025.0, 17087.572810679583, 17304.134793260288, 17330.046847423513, 17335.65328693419, 17338.0, 13231.073824832169, 13341.132826366254, 13379.933100334436, 13382.665433364049, 13392.598222053353, 18593.820595697216, 20148.798512014986, 20267.0, 20290.69563956542, 20360.18559257643, 7446.090802328821, 7567.356774674105, 7568.5837278950185, 7679.731209407644, 8034.879476807852, 898.4448844359167, 1079.7192729890285, 1103.200179869588, 1103.939283339424, 1131.7453572946185, 31757.523637145463, 33071.50392744111, 33227.667723322455, 33384.66615333864, 33450.81864766904, 1156.9595064172713, 1160.6692092753524, 1168.6669299249672, 1184.2894263441865, 1193.6061099837207, 17130.229139688745, 17259.654806903793, 17327.826721732872, 17397.304107835796, 17653.293868245128, 599112.0, 603153.0, 604815.0, 605349.0, 608065.0, 58787.41212587905, 59487.0, 59497.702511487165, 59671.403285967455, 59721.10418343728, 1230.9507619695291, 1296.5786119511008, 1299.1880074953153, 1346.602752188107, 1361.0948719101884, 30258.697413025588, 33506.0, 34292.48561271533, 34592.0, 34642.65357346394, 52031.219531706294, 52827.47172528225, 52868.0, 52913.0, 52933.206001910774, 523437.0, 532642.0, 532838.0, 535007.0, 535357.0, 35209.47185792266, 43956.78021609871, 44899.0, 47648.0, 47967.0, 49092.509074910224, 49229.50770492249, 49230.0, 49324.0, 49420.0, 41522.37716434316, 41602.16795664009, 42412.64001839411, 43200.13599728051, 43610.345844811716, 41983.790081049396, 42292.577074228866, 42746.358804618576, 42778.35832462453, 43153.13693726045, 41245.793771030956, 42108.789456052524, 42182.0, 42448.0, 42664.14671706486, 35755.46366804448, 37376.439353410264, 37571.81214093912, 37948.104985308695, 38513.80743096267, 27303.846230614447, 27827.0, 28064.71935280621, 28194.43611127807, 28327.575086374134], "value": 21095.754553070765, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.47342457272106, 380.36858814368156, 395.62613330402775, 401.17358242021436, 417.9331306990882, 14480.16709807017, 17513.949163050227, 18520.073996300183, 20052.097655605496, 20061.297854575092, 15772.526824195293, 19115.522111947208, 19778.604427911432, 19831.305904293316, 20094.999999999964, 5798.971005144968, 5979.0, 5987.341392446828, 5990.071538911476, 6015.278166620012, 5869.178315035899, 5931.673757943311, 5965.970170149143, 5973.671448070354, 5974.820755377345, 5716.79991200306, 5824.126381042856, 5872.442117998783, 5873.177755114288, 5887.058070708687, 5880.6765627890445, 5906.675132867691, 5927.881442371172, 5928.347881733006, 6914.723411063552, 6898.206706228798, 7022.543534670282, 7149.714011439536, 7150.284971502861, 7153.177384600785, 27323.726762732516, 27518.724812752018, 27869.58195627067, 27974.0, 27977.86011069952, 2449.2040086971806, 2492.7756501914914, 2560.46230291639, 2586.547354213024, 2650.774684151849, 15976.007639358617, 16076.839231607652, 16354.591135221595, 16447.0, 17347.21937512815, 1986.7218589397496, 2099.95800083999, 2113.408245691209, 2144.2280778919576, 2160.83793715472, 81215.0, 87164.12835871623, 90951.54524227337, 92635.53682231613, 99772.0, 18087.276508939758, 18209.544761380806, 18403.90798046001, 18447.631047378978, 18476.722849157275, 33024.50463243053, 33099.50350744741, 33107.834460827544, 33112.66887331144, 33313.333733325686, 10064.0, 10121.190304775748, 10148.898511014942, 10193.184545236363, 10443.895561044292, 8415.579221039046, 8533.74398768038, 8546.700865469678, 8771.342149338698, 8790.560471976503, 7482.4388170887405, 8540.871886921701, 9125.543722813965, 9143.54282285883, 9180.908190918006, 3041.442016588819, 3504.8247587620517, 3526.7883926964464, 3639.836207370675, 3646.872359467406, 856.9014563325297, 947.6114792934864, 951.6050838901916, 960.5149399553181, 1015.4110615842941, 19544.12051457688, 19894.204231830856, 19932.103055362542, 20388.184472621226, 20686.79313206879, 1006.9043440873252, 1010.4796030044533, 1026.2200727447193, 1050.4905121016302, 1078.816601177786, 10749.731256718489, 11161.72095697614, 11289.379084150287, 11302.265352752045, 11312.434378281054, 481542.0, 491786.0, 492163.0, 495887.0, 496336.0, 95378.0, 96013.5199324013, 96020.0, 96833.03166968381, 98066.5096674512, 947.5688561704408, 975.2295686407658, 986.6743974488402, 988.6292640259902, 996.6461906023258, 16313.26590303463, 17490.91254543719, 18244.90877545604, 18665.0, 18728.531786704898, 41904.3714344279, 46978.53021469741, 47195.52804471911, 47215.29177062278, 48847.0, 61295.38704612897, 62921.68539157275, 63517.0, 64479.48643595091, 65121.67439162774, 8610.526421046903, 9007.774805629911, 9020.503872287087, 9064.773380665536, 9302.860457093284, 10248.59005639796, 13842.930785346009, 13946.302684865514, 14419.567412977627, 14610.123392596479, 11899.76200476003, 11929.28424294545, 12030.27818330903, 12083.637490875288, 12084.274943503418, 10945.616903408343, 11109.444527773741, 11213.71965700864, 11486.655400338002, 11704.94147529257, 11491.828677095173, 11684.532618695157, 11888.167828252286, 12137.817932731192, 12327.630171094881, 8797.12028797115, 8870.955645221991, 8908.287337012895, 9312.44125352481, 9321.067893210897, 10893.291936024134, 12239.75520489603, 12259.141860070065, 12334.81497777516, 12359.443825028075], "value": 10451.480787484317, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1327.1240980952573, 1442.8412874583794, 1515.3029606381065, 1613.370785393696, 1755.9297628094869, 8446.324294056476, 8769.210771030606, 8849.646014159442, 9136.223421009205, 9147.496887671192, 8993.100689931003, 9096.954515227431, 9117.22503587196, 9124.22444092253, 9124.315676324286, 2358.964615530764, 2382.845115067515, 2384.904603815854, 2385.5348207099623, 2387.319613910036, 2305.4351683837485, 2339.6724458575814, 2360.834741568091, 2366.290112966112, 2367.609344458171, 2338.83628146029, 2358.6815779869758, 2369.834111612188, 2373.1812524679044, 2376.049580167938, 2256.954860902773, 2284.3832165315357, 2291.51878105598, 2291.6104262275453, 2341.2273949596593, 2284.7715228477186, 2289.381866895929, 2294.8508346957396, 2297.5060362022077, 2299.655051742235, 8929.821403571957, 8929.955350223207, 9030.819383612292, 9082.545872706338, 9087.818243635156, 5113.51421614946, 5288.735563221823, 5299.947000529984, 5302.628815982883, 5309.734513274359, 3480.6867381935494, 3530.682238598513, 3543.663351981583, 3583.0325812030605, 3587.677109060171, 1209.6431552691888, 1237.4555195713858, 1239.69007748063, 1249.7562975219835, 1270.5235536673747, 12297.692557686129, 12308.507659693601, 12326.938365308206, 12341.568045118378, 12394.0, 4284.635805956528, 4461.152381047591, 4570.611498022706, 4578.771061446914, 4627.329037289642, 9764.072413120743, 9766.267529935283, 9769.120779129913, 9770.36492627977, 9772.609095636237, 5262.657927234794, 5266.657667251693, 5267.815626453133, 5271.446498117719, 5280.339957505312, 4057.9797101014306, 4310.073334233155, 4429.379886815848, 4502.527234640381, 4896.608271338356, 3688.2254726507736, 3702.981680037957, 3776.0, 3831.540215174197, 3842.9039274018373, 1125.651048175052, 1151.6890439581266, 1159.1538177130742, 1164.4003338280793, 1173.2784337632295, 831.4637059096849, 844.3667249562828, 1002.0780881588955, 1004.1213937804421, 1026.471367245869, 6045.6070355426755, 6104.542159338067, 6192.783252586228, 6221.62670239778, 6311.558190926683, 977.1059480575336, 993.8459538771502, 998.5656239535825, 1003.1473247739509, 1004.5931397783909, 4060.451839001756, 4141.233871733739, 4168.7290326128705, 4283.700140990163, 4373.300271956536, 10847.51186196623, 10903.83644245337, 10997.505112269968, 11160.107191424666, 11177.21759476845, 11093.168012399103, 11104.777904441866, 11116.666500005012, 11125.221234513507, 11133.0, 8292.212239837207, 8489.660413583388, 8550.315974722007, 8553.44402613828, 8554.059053504234, 6055.878882422238, 6096.359882212481, 6146.354632763674, 6168.074788781719, 6311.621302721851, 10191.898081019392, 10287.742806429898, 10507.789844203226, 10518.474076296308, 10585.259031867696, 9425.952870235606, 10381.84427233577, 10482.161427085968, 10751.462426878468, 10830.187735919995, 8357.456765310235, 8450.450720703135, 8590.312774978112, 8764.298856091626, 8770.517621530622, 8648.264897483785, 8739.519326437106, 8742.781430464034, 8758.299336053227, 8762.07998160184, 7463.925360746323, 7631.580263085583, 7713.652885620048, 7745.341645960157, 7781.688732450639, 7741.419393545394, 7762.301392874669, 7794.415418843496, 7802.921970780447, 7903.9209607903185, 7186.676599553137, 7305.744298949511, 7320.63396830167, 7364.852702946018, 7390.815229619303, 5322.654027488201, 5407.2970513834525, 5434.83695489136, 5453.449383958553, 5565.16522521625, 5230.293910322058, 5240.109181439088, 5315.6279060465395, 5452.318460192476, 5509.614326997072], "value": 4701.92922534607, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.365269461078, 335.57382124701627, 340.14284004309155, 341.30203733365266, 342.28291728828094, 5029.522195391437, 5071.695698258102, 5143.897122057557, 5166.638335316525, 5186.559142472895, 5116.641835071547, 5121.897562048757, 5126.5642420394215, 5126.92309615356, 5141.383034035921, 4095.89760255993, 4100.815463304143, 4111.506619205685, 4117.4441450404265, 4124.278251306025, 4022.365350695299, 4085.81613827377, 4098.938515922264, 4144.544100148996, 4152.875413737593, 4063.2482990646827, 4068.65416439603, 4072.857449989251, 4086.5300490443533, 4090.8772736817796, 4075.7350772200007, 4077.857274995376, 4093.140440507497, 4097.97951010243, 4109.178164367138, 3658.5243918290716, 3668.0829792551863, 3669.733941790078, 3672.8347224374966, 3681.852725890961, 4814.2558741517, 5011.1481048221885, 5060.46865079165, 5060.78541150125, 5066.69599824008, 4607.470140933802, 4617.884552886205, 4621.145088158668, 4624.861254162381, 4636.907261854778, 5247.370315562157, 5382.703951282678, 5385.219143224211, 5401.353336864908, 5466.753996070186, 3906.867008567512, 3921.3529767588316, 3941.3890846918775, 3941.822617982169, 3978.4827972363696, 5294.570465974204, 5460.989716902386, 5592.720363981784, 5627.887442251132, 5634.859128521779, 3850.172212974224, 3867.16855875988, 3870.1292209253256, 3880.1463677990796, 3963.7819919904105, 3973.245083434196, 3996.8800935971967, 4003.8398464061693, 4020.512410408109, 4042.8180731867137, 4528.0691545183545, 4570.085982803453, 4588.325261279676, 4592.517785632461, 4595.310703394518, 5305.0, 5375.435579264121, 5398.595105367034, 5400.594955378284, 5402.594805389612, 1374.7387996280675, 1394.0868730981224, 1396.5321617258332, 1396.5461225101678, 1397.895157863144, 870.5734190246734, 906.6101576322113, 912.0, 927.5223260021095, 932.3147486597345, 4522.140793249272, 4561.521040290721, 4581.587657110809, 4596.287575425815, 4598.931016034762, 4829.6860704054125, 4877.6587238125185, 4908.803647854117, 4912.926306105412, 4936.211040761958, 4399.780010999501, 4574.908501829945, 4595.471520775087, 4596.897094461226, 4615.699979501322, 2577.046492797677, 2584.5477041518034, 2588.352911772057, 2588.4564241509115, 2606.4005278785608, 4984.40187177541, 5022.472640372781, 5029.748512574357, 5034.823781167642, 5076.263941728429, 4753.762311884392, 4951.232558953368, 4953.925691114636, 4989.625778066659, 5015.573676237561, 4907.312976183409, 4968.478309777493, 4984.875378115504, 5004.3494345734825, 5010.7179797232875, 4878.414590249051, 4878.536539028786, 4879.0, 4891.241857512091, 4899.828506002273, 4521.321801729635, 4819.903601927872, 4826.638002149783, 4864.756762161948, 4908.852734417973, 4842.854714358575, 4938.901221975469, 5444.918326225031, 5623.297087864017, 5741.224934633938, 3902.746321489094, 3922.37242041272, 3932.488776459042, 3943.329633962176, 3943.6056394360335, 5515.0, 5538.418466061166, 5553.361363443256, 5558.749856256397, 5613.943860561342, 5174.249733788504, 5330.493603107699, 5373.2746079278795, 5374.167004114369, 5437.184422336682, 5356.143017117242, 5374.355077390582, 5378.247045413567, 5383.650062745909, 5390.353157620953, 5334.599905007218, 5346.1713434417725, 5346.652467589594, 5386.111291636836, 5409.350877894678, 5160.948390516197, 5424.701641409602, 5440.292761940922, 5494.917576236279, 5496.642718223303, 5368.382635996754, 5369.6509726867625, 5375.731213439391, 5418.864528386822, 5450.5367043801725], "value": 4000.4875972664377, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [790.5809920742005, 822.1244374740901, 825.6037102190952, 825.9669613215472, 835.8119423129795, 15970.281337339818, 16365.83634163658, 17174.82825171751, 17295.913520432397, 17305.82694173058, 15661.138637374968, 15863.92068039661, 15874.84125158748, 15887.920560397211, 15898.364065437368, 789.5420656019495, 810.8013536683521, 812.3785304242259, 813.2436833744615, 813.8616435206029, 654.5679851298145, 789.6328207383566, 809.8056466448039, 810.0401024785648, 818.4189225649766, 852.2585350744861, 852.6887685994599, 852.7740148860526, 854.5342788180457, 855.422589751918, 852.6376290076723, 853.4580541356283, 853.9957300213521, 854.2439940652505, 854.478767951549, 499.42431628213046, 588.2059220052937, 610.4261993725884, 612.2408213814838, 612.9080637904306, 15201.771973420407, 15325.693486130327, 15359.923200384039, 15395.153266570334, 15403.0, 13277.601671949857, 13712.17726936377, 14505.129692218501, 14758.55724328272, 14852.2573871306, 11807.822882656767, 11882.346470944094, 11890.405479726065, 11928.40357982106, 12171.756564868741, 4375.606195442394, 4418.469783625953, 4473.544435123193, 4517.412736344254, 4547.226971414867, 83270.0, 83504.0, 84637.0, 84742.15257847404, 84941.57529212315, 11560.884391156149, 11583.247088939192, 11875.40622968848, 11953.820692689616, 12032.27806331623, 22205.0, 22284.442888927908, 22295.88852055762, 22303.776962230495, 22419.10323587071, 8748.825023499494, 8754.47473151613, 8784.297256219486, 8906.332025098143, 9126.771830704285, 4538.0, 4621.607163391082, 4630.351750754897, 4738.597219236334, 4952.083864485082, 3459.844307006191, 3472.218750781054, 3528.947065794015, 3535.4520049392386, 3562.4656301554974, 614.6588643302921, 617.4103730937035, 625.327772644409, 625.3902445116066, 627.3350248736263, 656.8259411256021, 684.8253695307665, 697.2748341724651, 712.2058904321748, 721.271515769077, 9624.711258662252, 9773.267004974656, 9858.162056225301, 9870.901290986998, 10009.349392289478, 567.3107174782659, 637.7321524959528, 657.9539432239793, 660.379243511098, 661.4258065803454, 4417.845375411845, 4706.882327941828, 4711.4193708199155, 4719.0, 4790.712557246507, 124748.01351903746, 130922.0, 132815.0, 134375.0, 136451.0, 107508.0, 108418.0, 110544.0, 110654.0, 113493.43253283846, 58227.12659310114, 73398.0, 83647.58176209201, 84245.99999999878, 87394.0, 9733.415995040321, 10312.845307320546, 10467.476626168813, 10521.105706015074, 10688.412137332522, 52515.0, 52834.73582632062, 53528.732356339526, 53814.19278710901, 53910.46089539054, 74773.0, 77014.61492692724, 79571.60214199123, 79757.0, 82703.5864820672, 12730.87269127334, 13202.537911173447, 13384.263865487103, 13498.797518037041, 13618.863811362156, 15257.694846103237, 15404.614884627974, 15431.196388485643, 15447.0, 15531.758195823979, 14063.578092657237, 14078.366473508511, 14296.57110286693, 14484.203368814817, 14986.550403487912, 12769.872301276868, 12960.287184204959, 13335.66660833487, 13439.46242150303, 13750.174989500661, 13900.582982510541, 13972.860271397563, 13985.790213146607, 14062.859371406155, 14071.226082565558, 11278.266912650652, 11537.826932596186, 11739.823902641296, 11912.0, 12220.4139956736, 10855.782884342427, 11388.14588905852, 11399.943000284946, 11491.0, 11500.884991149982], "value": 7741.5856395761575, "unit": "score"}], "name": "dromaeo_css", "value": 7422.856526846192, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 112.0, 110.0, 111.0, 111.0, 111.0, 111.0, 111.0, 111.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 118.0, 121.0, 173.0, 118.0, 118.0, 139.0, 120.0, 163.0, 118.0], "value": 133.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 159.0, 160.0, 159.0, 160.0, 161.0, 160.0, 161.0, 161.0, 160.0], "value": 160.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 75.0, 127.0, 75.0, 76.0, 73.0, 74.0, 111.0, 76.0], "value": 83.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 128.0, 83.0, 82.0, 84.0, 119.0, 84.0, 84.0, 132.0], "value": 96.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 53.0, 51.0, 52.0, 52.0, 52.0, 49.0, 51.0, 51.0, 51.0], "value": 51.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 62.0, 61.0, 62.0, 61.0, 60.0, 61.0, 61.0, 61.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 76.0, 76.0, 86.0, 79.0, 76.0, 76.0, 74.0], "value": 77.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 123.0, 123.0, 124.0, 127.0, 122.0, 136.0, 121.0, 153.0, 131.0], "value": 129.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 165.0, 162.0, 161.0, 159.0, 161.0, 160.0, 158.0, 159.0, 155.0], "value": 159.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 63.0, 64.0, 64.0, 63.0, 62.0, 62.0, 62.0], "value": 63.1, "unit": "score"}], "name": "kraken", "value": 1481.6999999999998, "alertThreshold": 2.0}]} 17:40:24 INFO - Return code: 0 17:40:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:40:24 INFO - # TBPL SUCCESS # 17:40:24 INFO - Running post-action listener: _resource_record_post_action 17:40:24 INFO - [mozharness: 2016-08-05 00:40:24.293856Z] Finished run-tests step (success) 17:40:24 INFO - Running post-run listener: _resource_record_post_run 17:40:24 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 551809024; Read time: 12; Write time: 608988 17:40:24 INFO - TinderboxPrint: CPU usage
13.1% 17:40:24 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 17:40:24 INFO - TinderboxPrint: I/O write bytes / time
551,809,024 / 608,988 17:40:24 INFO - TinderboxPrint: CPU idle
8,273.2 (86.9%) 17:40:24 INFO - TinderboxPrint: CPU user
1,200.3 (12.6%) 17:40:24 INFO - TinderboxPrint: Swap in / out
0 / 0 17:40:24 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 258285568; Read time: 0; Write time: 364720 17:40:24 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 293523456; Read time: 0; Write time: 244268 17:40:24 INFO - Running post-run listener: _upload_blobber_files 17:40:24 INFO - Blob upload gear active. 17:40:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:40:24 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 17:40:24 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:40:24 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:40:25 INFO - (blobuploader) - INFO - Open directory for files ... 17:40:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:40:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:40:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:40:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:40:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:40:29 INFO - (blobuploader) - INFO - Done attempting. 17:40:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:40:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:40:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:40:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:40:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:40:29 INFO - (blobuploader) - INFO - Done attempting. 17:40:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:40:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:40:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:40:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:40:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:40:30 INFO - (blobuploader) - INFO - Done attempting. 17:40:30 INFO - (blobuploader) - INFO - Iteration through files over. 17:40:30 INFO - Return code: 0 17:40:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:40:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:40:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ed2c7a7b8c43b90298564ebc72877ae83345bcc89a31f4426d4c66812723069adc9f4298da7910c42432353f462b06c823605c01938028618d690eb0e12ef52f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/280c4fe489096c0b01f0d9d7fd01ed1fae28a90b16423c06e08b3575eac3fc5dda61fc50ba61066881250757a0219fa8fb3b726982fde0616942e4dc0a15cabd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/16d36039d472638dd6e864b4ed1c8b7ccb4de561c215db7c0f1973cb352ccad68dd6ed46ec13af2ee96576758234788227f7393251a8e9e8242481f0360b2fcb"} 17:40:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:40:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:40:30 INFO - Contents: 17:40:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ed2c7a7b8c43b90298564ebc72877ae83345bcc89a31f4426d4c66812723069adc9f4298da7910c42432353f462b06c823605c01938028618d690eb0e12ef52f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/280c4fe489096c0b01f0d9d7fd01ed1fae28a90b16423c06e08b3575eac3fc5dda61fc50ba61066881250757a0219fa8fb3b726982fde0616942e4dc0a15cabd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/16d36039d472638dd6e864b4ed1c8b7ccb4de561c215db7c0f1973cb352ccad68dd6ed46ec13af2ee96576758234788227f7393251a8e9e8242481f0360b2fcb"} 17:40:30 INFO - Running post-run listener: copy_logs_to_upload_dir 17:40:30 INFO - Copying logs to upload dir... 17:40:30 INFO - mkdir: /builds/slave/test/build/upload/logs 17:40:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.833847 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-08-04 17:40:30.648311) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 17:40:30.651921) ========= 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=db0483c52d987ecb441a263b000001ad-1470356198.260135-1506876525 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/sha512/ed2c7a7b8c43b90298564ebc72877ae83345bcc89a31f4426d4c66812723069adc9f4298da7910c42432353f462b06c823605c01938028618d690eb0e12ef52f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/280c4fe489096c0b01f0d9d7fd01ed1fae28a90b16423c06e08b3575eac3fc5dda61fc50ba61066881250757a0219fa8fb3b726982fde0616942e4dc0a15cabd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/16d36039d472638dd6e864b4ed1c8b7ccb4de561c215db7c0f1973cb352ccad68dd6ed46ec13af2ee96576758234788227f7393251a8e9e8242481f0360b2fcb"} build_url:https://queue.taskcluster.net/v1/task/Pbuz5S7lTSu88t5EcIoUmA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011355 build_url: 'https://queue.taskcluster.net/v1/task/Pbuz5S7lTSu88t5EcIoUmA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ed2c7a7b8c43b90298564ebc72877ae83345bcc89a31f4426d4c66812723069adc9f4298da7910c42432353f462b06c823605c01938028618d690eb0e12ef52f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/280c4fe489096c0b01f0d9d7fd01ed1fae28a90b16423c06e08b3575eac3fc5dda61fc50ba61066881250757a0219fa8fb3b726982fde0616942e4dc0a15cabd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/16d36039d472638dd6e864b4ed1c8b7ccb4de561c215db7c0f1973cb352ccad68dd6ed46ec13af2ee96576758234788227f7393251a8e9e8242481f0360b2fcb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 17:40:30.677283) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 17:40:30.677604) ========= 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=db0483c52d987ecb441a263b000001ad-1470356198.260135-1506876525 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004587 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 17:40:30.761967) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 17:40:30.762274) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 17:40:30.762555) ========= ========= Total master_lag: 0.18 =========