builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-034 starttime: 1472134851.27 results: success (0) buildid: 20160825060025 builduid: e04653e25e524750ab5c27116032cc4e revision: 7963ebdd52b93f96b812eff2eab8d94097147b9c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-25 07:20:51.267000) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-25 07:20:51.267615) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-25 07:20:51.267907) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-25 07:20:51.303388) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 07:20:51.303654) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1472134252.930079-1383729287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-25 07:20:51-- 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% 222M=0s 2016-08-25 07:20:51 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.092614 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 07:20:51.410033) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 07:20:51.410368) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1472134252.930079-1383729287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023109 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 07:20:51.459825) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 07:20:51.460188) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7963ebdd52b93f96b812eff2eab8d94097147b9c --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 7963ebdd52b93f96b812eff2eab8d94097147b9c --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=d6bbd613908ccac0c6c9cb47000001f7-1472134252.930079-1383729287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-25 07:20:51,624 truncating revision to first 12 chars 2016-08-25 07:20:51,624 Setting DEBUG logging. 2016-08-25 07:20:51,624 attempt 1/10 2016-08-25 07:20:51,624 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7963ebdd52b9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-25 07:20:51,886 unpacking tar archive at: fx-team-7963ebdd52b9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.551023 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 07:20:52.025038) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-25 07:20:52.025343) ========= script_repo_revision: 7963ebdd52b93f96b812eff2eab8d94097147b9c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-25 07:20:52.025733) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-25 07:20:52.026008) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-25 07:20:52.035526) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 14 secs) (at 2016-08-25 07:20:52.035948) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1472134252.930079-1383729287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:20:52 INFO - MultiFileLogger online at 20160825 07:20:52 in /builds/slave/test 07:20:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 07:20:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:20:52 INFO - {'append_to_log': False, 07:20:52 INFO - 'base_work_dir': '/builds/slave/test', 07:20:52 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:20:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:20:52 INFO - 'branch': 'Fx-Team-Non-PGO', 07:20:52 INFO - 'buildbot_json_path': 'buildprops.json', 07:20:52 INFO - 'config_files': ('talos/linux_config.py',), 07:20:52 INFO - 'default_actions': ('clobber', 07:20:52 INFO - 'read-buildbot-config', 07:20:52 INFO - 'download-and-extract', 07:20:52 INFO - 'populate-webroot', 07:20:52 INFO - 'create-virtualenv', 07:20:52 INFO - 'install', 07:20:52 INFO - 'run-tests'), 07:20:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:20:52 INFO - 'download_minidump_stackwalk': True, 07:20:52 INFO - 'download_symbols': 'ondemand', 07:20:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:20:52 INFO - 'tooltool.py': '/tools/tooltool.py', 07:20:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:20:52 INFO - '/tools/misc-python/virtualenv.py')}, 07:20:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:20:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:20:52 INFO - 'installer_path': 'installer.exe', 07:20:52 INFO - 'log_level': 'info', 07:20:52 INFO - 'log_name': 'talos', 07:20:52 INFO - 'log_to_console': True, 07:20:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:20:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:20:52 INFO - 'opt_config_files': (), 07:20:52 INFO - 'pip_index': False, 07:20:52 INFO - 'sps_profile': False, 07:20:52 INFO - 'sps_profile_interval': 0, 07:20:52 INFO - 'suite': 'dromaeojs', 07:20:52 INFO - 'system_bits': '32', 07:20:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:20:52 INFO - 'title': 'talos-linux64-ix-034', 07:20:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:20:52 INFO - 'use_talos_json': True, 07:20:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:20:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:20:52 INFO - 'work_dir': 'build'} 07:20:52 INFO - [mozharness: 2016-08-25 14:20:52.289540Z] Running clobber step. 07:20:52 INFO - Running pre-action listener: _resource_record_pre_action 07:20:52 INFO - Running main action method: clobber 07:20:52 INFO - rmtree: /builds/slave/test/build 07:20:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:20:52 INFO - Running post-action listener: _resource_record_post_action 07:20:52 INFO - [mozharness: 2016-08-25 14:20:52.739944Z] Finished clobber step (success) 07:20:52 INFO - [mozharness: 2016-08-25 14:20:52.740045Z] Running read-buildbot-config step. 07:20:52 INFO - Running pre-action listener: _resource_record_pre_action 07:20:52 INFO - Running main action method: read_buildbot_config 07:20:52 INFO - Using buildbot properties: 07:20:52 INFO - { 07:20:52 INFO - "project": "", 07:20:52 INFO - "product": "firefox", 07:20:52 INFO - "script_repo_revision": "production", 07:20:52 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 07:20:52 INFO - "repository": "", 07:20:52 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 07:20:52 INFO - "buildid": "20160825060025", 07:20:52 INFO - "pgo_build": "False", 07:20:52 INFO - "basedir": "/builds/slave/test", 07:20:52 INFO - "buildnumber": 1884, 07:20:52 INFO - "slavename": "talos-linux64-ix-034", 07:20:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:20:52 INFO - "platform": "ubuntu64_hw", 07:20:52 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:20:52 INFO - "branch": "fx-team", 07:20:52 INFO - "repo_path": "integration/fx-team", 07:20:52 INFO - "revision": "7963ebdd52b93f96b812eff2eab8d94097147b9c", 07:20:52 INFO - "stage_platform": "linux64", 07:20:52 INFO - "builduid": "e04653e25e524750ab5c27116032cc4e", 07:20:52 INFO - "slavebuilddir": "test" 07:20:52 INFO - } 07:20:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/DrZF3wgaT3aReiDHmNm8Ow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 07:20:52 INFO - Running post-action listener: _resource_record_post_action 07:20:52 INFO - [mozharness: 2016-08-25 14:20:52.742438Z] Finished read-buildbot-config step (success) 07:20:52 INFO - [mozharness: 2016-08-25 14:20:52.742525Z] Running download-and-extract step. 07:20:52 INFO - Running pre-action listener: _resource_record_pre_action 07:20:52 INFO - Running main action method: download_and_extract 07:20:52 INFO - mkdir: /builds/slave/test/build/tests 07:20:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:20:52 INFO - trying https://queue.taskcluster.net/v1/task/DrZF3wgaT3aReiDHmNm8Ow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 07:20:52 INFO - Downloading https://queue.taskcluster.net/v1/task/DrZF3wgaT3aReiDHmNm8Ow/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 07:20:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DrZF3wgaT3aReiDHmNm8Ow/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 07:20:53 INFO - Downloaded 1361 bytes. 07:20:53 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 07:20:53 INFO - Using the following test package requirements: 07:20:53 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 07:20:53 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:20:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:20:53 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:20:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:20:53 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:20:53 INFO - u'jsshell-linux-x86_64.zip'], 07:20:53 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:20:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:20:53 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 07:20:53 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:20:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:20:53 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:20:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:20:53 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:20:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:20:53 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:20:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:20:53 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:20:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:20:53 INFO - trying https://queue.taskcluster.net/v1/task/DrZF3wgaT3aReiDHmNm8Ow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:20:53 INFO - Downloading https://queue.taskcluster.net/v1/task/DrZF3wgaT3aReiDHmNm8Ow/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 07:20:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DrZF3wgaT3aReiDHmNm8Ow/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 07:20:55 INFO - Downloaded 20324517 bytes. 07:20:55 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 07:20:59 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 07:20: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')]} 07:20:59 INFO - trying https://queue.taskcluster.net/v1/task/DrZF3wgaT3aReiDHmNm8Ow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:20:59 INFO - Downloading https://queue.taskcluster.net/v1/task/DrZF3wgaT3aReiDHmNm8Ow/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 07:20:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DrZF3wgaT3aReiDHmNm8Ow/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 07:21:00 INFO - Downloaded 20324517 bytes. 07:21:00 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 07:21: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')]} 07:21:04 INFO - trying https://queue.taskcluster.net/v1/task/DrZF3wgaT3aReiDHmNm8Ow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 07:21:04 INFO - Downloading https://queue.taskcluster.net/v1/task/DrZF3wgaT3aReiDHmNm8Ow/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 07:21:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DrZF3wgaT3aReiDHmNm8Ow/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 07:21:06 INFO - Downloaded 14413981 bytes. 07:21:06 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 07:21: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')]} 07:21:06 INFO - trying https://queue.taskcluster.net/v1/task/DrZF3wgaT3aReiDHmNm8Ow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:21:06 INFO - Downloading https://queue.taskcluster.net/v1/task/DrZF3wgaT3aReiDHmNm8Ow/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 07:21:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DrZF3wgaT3aReiDHmNm8Ow/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 07:21:09 INFO - Downloaded 55746434 bytes. 07:21:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DrZF3wgaT3aReiDHmNm8Ow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:21:09 INFO - mkdir: /builds/slave/test/properties 07:21:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:21:09 INFO - Writing to file /builds/slave/test/properties/build_url 07:21:09 INFO - Contents: 07:21:09 INFO - build_url:https://queue.taskcluster.net/v1/task/DrZF3wgaT3aReiDHmNm8Ow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:21:09 INFO - Running post-action listener: _resource_record_post_action 07:21:09 INFO - Running post-action listener: set_extra_try_arguments 07:21:09 INFO - [mozharness: 2016-08-25 14:21:09.672582Z] Finished download-and-extract step (success) 07:21:09 INFO - [mozharness: 2016-08-25 14:21:09.672806Z] Running populate-webroot step. 07:21:09 INFO - Running pre-action listener: _resource_record_pre_action 07:21:09 INFO - Running main action method: populate_webroot 07:21:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:21:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:21:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:21:09 INFO - '--tppagecycles', 07:21:09 INFO - '7'], 07:21:09 INFO - 'tests': ['tsvgm']}}, 07:21:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:21:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:21:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:21:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:21:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:21:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:21:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:21:09 INFO - 'talos_options': ['--disable-e10s'], 07:21:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:21:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:21:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:21:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:21:09 INFO - 'talos_options': ['--disable-e10s'], 07:21:09 INFO - 'tests': ['damp', 'tps']}, 07:21:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:21:09 INFO - 'tests': ['damp', 'tps']}, 07:21:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:21:09 INFO - 'tests': ['dromaeo_dom']}, 07:21:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:21:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:21:09 INFO - 'tests': ['basic_compositor_video']}, 07:21:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:21:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:21:09 INFO - 'tests': ['a11yr', 07:21:09 INFO - 'ts_paint', 07:21:09 INFO - 'tpaint', 07:21:09 INFO - 'sessionrestore', 07:21:09 INFO - 'sessionrestore_no_auto_restore', 07:21:09 INFO - 'tabpaint']}, 07:21:09 INFO - 'other-e10s': {'tests': ['a11yr', 07:21:09 INFO - 'ts_paint', 07:21:09 INFO - 'tpaint', 07:21:09 INFO - 'sessionrestore', 07:21:09 INFO - 'sessionrestore_no_auto_restore', 07:21:09 INFO - 'tabpaint']}, 07:21:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:21:09 INFO - 'ts_paint', 07:21:09 INFO - 'tpaint', 07:21:09 INFO - 'sessionrestore', 07:21:09 INFO - 'sessionrestore_no_auto_restore', 07:21:09 INFO - 'tabpaint']}, 07:21:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:21:09 INFO - 'ts_paint', 07:21:09 INFO - 'tpaint', 07:21:09 INFO - 'sessionrestore', 07:21:09 INFO - 'sessionrestore_no_auto_restore', 07:21:09 INFO - 'tabpaint']}, 07:21:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:21:09 INFO - 'tests': ['a11yr', 07:21:09 INFO - 'ts_paint', 07:21:09 INFO - 'tpaint', 07:21:09 INFO - 'sessionrestore', 07:21:09 INFO - 'sessionrestore_no_auto_restore', 07:21:09 INFO - 'tabpaint']}, 07:21:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:21:09 INFO - 'tests': ['a11yr', 07:21:09 INFO - 'ts_paint', 07:21:09 INFO - 'tpaint', 07:21:09 INFO - 'sessionrestore', 07:21:09 INFO - 'sessionrestore_no_auto_restore', 07:21:09 INFO - 'tabpaint']}, 07:21:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:21:09 INFO - 'tests': ['tsvgx', 07:21:09 INFO - 'tsvgr_opacity', 07:21:09 INFO - 'tart', 07:21:09 INFO - 'tscrollx', 07:21:09 INFO - 'cart']}, 07:21:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:21:09 INFO - 'tsvgr_opacity', 07:21:09 INFO - 'tart', 07:21:09 INFO - 'tscrollx', 07:21:09 INFO - 'cart']}, 07:21:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:21:09 INFO - 'talos_options': ['--disable-e10s'], 07:21:09 INFO - 'tests': ['tp5o']}, 07:21:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:21:09 INFO - 'tests': ['tp5o']}, 07:21:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:21:09 INFO - 'talos_options': ['--disable-e10s', 07:21:09 INFO - '--xperf_path', 07:21:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:21:09 INFO - 'tests': ['tp5n']}, 07:21:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:21:09 INFO - 'talos_options': ['--xperf_path', 07:21:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:21:09 INFO - 'tests': ['tp5n']}}, 07:21:09 INFO - 'talos.zip': {'path': '', 07:21:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:21:09 INFO - Running post-action listener: _resource_record_post_action 07:21:09 INFO - [mozharness: 2016-08-25 14:21:09.695110Z] Finished populate-webroot step (success) 07:21:09 INFO - [mozharness: 2016-08-25 14:21:09.695197Z] Running create-virtualenv step. 07:21:09 INFO - Running pre-action listener: _resource_record_pre_action 07:21:09 INFO - Running main action method: create_virtualenv 07:21:09 INFO - Creating virtualenv /builds/slave/test/build/venv 07:21: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 07:21:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:21:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:21:09 INFO - Using real prefix '/usr' 07:21:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:21:10 INFO - Installing distribute.............................................................................................................................................................................................done. 07:21:12 INFO - Installing pip.................done. 07:21:12 INFO - Return code: 0 07:21:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:21:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:21:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:21:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:21:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21:12 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 0x7fa80b58ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d3230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cd090>, '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 0x19d09b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d0e40>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1472134252.930079-1383729287', '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 07:21:12 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 07:21:12 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 07:21:12 INFO - Using env: {'DISPLAY': ':0', 07:21:12 INFO - 'HOME': '/home/cltbld', 07:21:12 INFO - 'LANG': 'en_US.UTF-8', 07:21:12 INFO - 'LANGUAGE': 'en_US:en', 07:21:12 INFO - 'LOGNAME': 'cltbld', 07:21:12 INFO - 'MAIL': '/var/mail/cltbld', 07:21:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:21:12 INFO - 'MOZ_NO_REMOTE': '1', 07:21:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:21:12 INFO - 'NO_EM_RESTART': '1', 07:21:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:21:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:21:12 INFO - 'PWD': '/builds/slave/test', 07:21:12 INFO - 'SHELL': '/bin/bash', 07:21:12 INFO - 'SHLVL': '1', 07:21:12 INFO - 'TERM': 'linux', 07:21:12 INFO - 'TMOUT': '86400', 07:21:12 INFO - 'USER': 'cltbld', 07:21:12 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1472134252.930079-1383729287', 07:21:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:21:12 INFO - '_': '/tools/buildbot/bin/python'} 07:21:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:21:12 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 07:21:12 INFO - Cleaning up... 07:21:12 INFO - Return code: 0 07:21:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:21:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:21:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:21:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:21:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21:12 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 0x7fa80b58ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d3230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cd090>, '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 0x19d09b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d0e40>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1472134252.930079-1383729287', '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 07:21:12 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 07:21:12 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 07:21:12 INFO - Using env: {'DISPLAY': ':0', 07:21:12 INFO - 'HOME': '/home/cltbld', 07:21:12 INFO - 'LANG': 'en_US.UTF-8', 07:21:12 INFO - 'LANGUAGE': 'en_US:en', 07:21:12 INFO - 'LOGNAME': 'cltbld', 07:21:12 INFO - 'MAIL': '/var/mail/cltbld', 07:21:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:21:12 INFO - 'MOZ_NO_REMOTE': '1', 07:21:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:21:12 INFO - 'NO_EM_RESTART': '1', 07:21:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:21:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:21:12 INFO - 'PWD': '/builds/slave/test', 07:21:12 INFO - 'SHELL': '/bin/bash', 07:21:12 INFO - 'SHLVL': '1', 07:21:12 INFO - 'TERM': 'linux', 07:21:12 INFO - 'TMOUT': '86400', 07:21:12 INFO - 'USER': 'cltbld', 07:21:12 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1472134252.930079-1383729287', 07:21:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:21:12 INFO - '_': '/tools/buildbot/bin/python'} 07:21:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:21:12 INFO - Downloading/unpacking psutil>=3.1.1 07:21: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 07:21: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 07:21: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 07:21: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 07:21: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 07:21: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 07:21:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:21:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:21:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:21:14 INFO - Installing collected packages: psutil 07:21:14 INFO - Running setup.py install for psutil 07:21:14 INFO - building 'psutil._psutil_linux' extension 07:21: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 07:21: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 07:21:14 INFO - building 'psutil._psutil_posix' extension 07:21: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 07:21:15 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 07:21:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:21:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:21:15 INFO - Successfully installed psutil 07:21:15 INFO - Cleaning up... 07:21:15 INFO - Return code: 0 07:21:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:21:15 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')]} 07:21:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:21:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21:15 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')]} 07:21:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:21:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21:15 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 0x7fa80b58ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d3230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cd090>, '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 0x19d09b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d0e40>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1472134252.930079-1383729287', '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 07:21:15 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 07:21:15 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 07:21:15 INFO - Using env: {'DISPLAY': ':0', 07:21:15 INFO - 'HOME': '/home/cltbld', 07:21:15 INFO - 'LANG': 'en_US.UTF-8', 07:21:15 INFO - 'LANGUAGE': 'en_US:en', 07:21:15 INFO - 'LOGNAME': 'cltbld', 07:21:15 INFO - 'MAIL': '/var/mail/cltbld', 07:21:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:21:15 INFO - 'MOZ_NO_REMOTE': '1', 07:21:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:21:15 INFO - 'NO_EM_RESTART': '1', 07:21:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:21:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:21:15 INFO - 'PWD': '/builds/slave/test', 07:21:15 INFO - 'SHELL': '/bin/bash', 07:21:15 INFO - 'SHLVL': '1', 07:21:15 INFO - 'TERM': 'linux', 07:21:15 INFO - 'TMOUT': '86400', 07:21:15 INFO - 'USER': 'cltbld', 07:21:15 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1472134252.930079-1383729287', 07:21:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:21:15 INFO - '_': '/tools/buildbot/bin/python'} 07:21:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:21:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:21:15 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 07:21:15 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 07:21:15 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 07:21:15 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 07:21:15 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 07:21:15 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 07:21:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:21:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:21:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:21:17 INFO - Installing collected packages: mozsystemmonitor 07:21:17 INFO - Running setup.py install for mozsystemmonitor 07:21:17 INFO - Successfully installed mozsystemmonitor 07:21:17 INFO - Cleaning up... 07:21:17 INFO - Return code: 0 07:21:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:21: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')]} 07:21:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:21:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21: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')]} 07:21:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:21:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21: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 0x7fa80b58ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d3230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cd090>, '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 0x19d09b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d0e40>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1472134252.930079-1383729287', '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 07:21: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 07:21: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 07:21:17 INFO - Using env: {'DISPLAY': ':0', 07:21:17 INFO - 'HOME': '/home/cltbld', 07:21:17 INFO - 'LANG': 'en_US.UTF-8', 07:21:17 INFO - 'LANGUAGE': 'en_US:en', 07:21:17 INFO - 'LOGNAME': 'cltbld', 07:21:17 INFO - 'MAIL': '/var/mail/cltbld', 07:21:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:21:17 INFO - 'MOZ_NO_REMOTE': '1', 07:21:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:21:17 INFO - 'NO_EM_RESTART': '1', 07:21:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:21:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:21:17 INFO - 'PWD': '/builds/slave/test', 07:21:17 INFO - 'SHELL': '/bin/bash', 07:21:17 INFO - 'SHLVL': '1', 07:21:17 INFO - 'TERM': 'linux', 07:21:17 INFO - 'TMOUT': '86400', 07:21:17 INFO - 'USER': 'cltbld', 07:21:17 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1472134252.930079-1383729287', 07:21:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:21:17 INFO - '_': '/tools/buildbot/bin/python'} 07:21:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:21:17 INFO - Downloading/unpacking jsonschema==2.5.1 07:21: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 07:21: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 07:21: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 07:21: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 07:21: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 07:21: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 07:21:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:21:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:21: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 07:21: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 07:21: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 07:21: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 07:21: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 07:21: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 07:21:19 INFO - Downloading functools32-3.2.3-2.tar.gz 07:21:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:21:19 INFO - warning: no files found matching '*.txt' 07:21:19 INFO - no previously-included directories found matching 'build' 07:21:19 INFO - no previously-included directories found matching 'dist' 07:21:19 INFO - no previously-included directories found matching '.git*' 07:21:19 INFO - Installing collected packages: jsonschema, functools32 07:21:19 INFO - Running setup.py install for functools32 07:21:20 INFO - warning: no files found matching '*.txt' 07:21:20 INFO - no previously-included directories found matching 'build' 07:21:20 INFO - no previously-included directories found matching 'dist' 07:21:20 INFO - no previously-included directories found matching '.git*' 07:21:20 INFO - Successfully installed jsonschema functools32 07:21:20 INFO - Cleaning up... 07:21:20 INFO - Return code: 0 07:21:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:21:20 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')]} 07:21:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:21:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21:20 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')]} 07:21:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:21:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21:20 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 0x7fa80b58ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d3230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cd090>, '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 0x19d09b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d0e40>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1472134252.930079-1383729287', '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 07:21:20 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 07:21:20 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 07:21:20 INFO - Using env: {'DISPLAY': ':0', 07:21:20 INFO - 'HOME': '/home/cltbld', 07:21:20 INFO - 'LANG': 'en_US.UTF-8', 07:21:20 INFO - 'LANGUAGE': 'en_US:en', 07:21:20 INFO - 'LOGNAME': 'cltbld', 07:21:20 INFO - 'MAIL': '/var/mail/cltbld', 07:21:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:21:20 INFO - 'MOZ_NO_REMOTE': '1', 07:21:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:21:20 INFO - 'NO_EM_RESTART': '1', 07:21:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:21:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:21:20 INFO - 'PWD': '/builds/slave/test', 07:21:20 INFO - 'SHELL': '/bin/bash', 07:21:20 INFO - 'SHLVL': '1', 07:21:20 INFO - 'TERM': 'linux', 07:21:20 INFO - 'TMOUT': '86400', 07:21:20 INFO - 'USER': 'cltbld', 07:21:20 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1472134252.930079-1383729287', 07:21:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:21:20 INFO - '_': '/tools/buildbot/bin/python'} 07:21:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:21:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:21:20 INFO - Cleaning up... 07:21:20 INFO - Return code: 0 07:21:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:21:20 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')]} 07:21:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:21:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21:20 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')]} 07:21:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:21:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21:20 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 0x7fa80b58ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d3230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cd090>, '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 0x19d09b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d0e40>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1472134252.930079-1383729287', '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 07:21:20 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 07:21:20 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 07:21:20 INFO - Using env: {'DISPLAY': ':0', 07:21:20 INFO - 'HOME': '/home/cltbld', 07:21:20 INFO - 'LANG': 'en_US.UTF-8', 07:21:20 INFO - 'LANGUAGE': 'en_US:en', 07:21:20 INFO - 'LOGNAME': 'cltbld', 07:21:20 INFO - 'MAIL': '/var/mail/cltbld', 07:21:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:21:20 INFO - 'MOZ_NO_REMOTE': '1', 07:21:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:21:20 INFO - 'NO_EM_RESTART': '1', 07:21:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:21:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:21:20 INFO - 'PWD': '/builds/slave/test', 07:21:20 INFO - 'SHELL': '/bin/bash', 07:21:20 INFO - 'SHLVL': '1', 07:21:20 INFO - 'TERM': 'linux', 07:21:20 INFO - 'TMOUT': '86400', 07:21:20 INFO - 'USER': 'cltbld', 07:21:20 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1472134252.930079-1383729287', 07:21:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:21:20 INFO - '_': '/tools/buildbot/bin/python'} 07:21:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:21:20 INFO - Downloading/unpacking blobuploader==1.2.4 07:21:20 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 07:21:20 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 07:21:20 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 07:21:20 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 07:21:20 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 07:21:20 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 07:21:22 INFO - Downloading blobuploader-1.2.4.tar.gz 07:21:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:21:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:21: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 07:21: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 07:21: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 07:21: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 07:21: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 07:21: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 07:21:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:21:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:21: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 07:21: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 07:21: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 07:21: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 07:21: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 07:21: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 07:21:23 INFO - Downloading docopt-0.6.1.tar.gz 07:21:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:21:23 INFO - Installing collected packages: blobuploader, requests, docopt 07:21:23 INFO - Running setup.py install for blobuploader 07:21:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:21:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:21:23 INFO - Running setup.py install for requests 07:21:23 INFO - Running setup.py install for docopt 07:21:23 INFO - Successfully installed blobuploader requests docopt 07:21:23 INFO - Cleaning up... 07:21:23 INFO - Return code: 0 07:21:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:21: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')]} 07:21:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:21:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21: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')]} 07:21:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:21:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21: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 0x7fa80b58ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d3230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cd090>, '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 0x19d09b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d0e40>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1472134252.930079-1383729287', '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 07:21: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 07:21: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 07:21:23 INFO - Using env: {'DISPLAY': ':0', 07:21:23 INFO - 'HOME': '/home/cltbld', 07:21:23 INFO - 'LANG': 'en_US.UTF-8', 07:21:23 INFO - 'LANGUAGE': 'en_US:en', 07:21:23 INFO - 'LOGNAME': 'cltbld', 07:21:23 INFO - 'MAIL': '/var/mail/cltbld', 07:21:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:21:23 INFO - 'MOZ_NO_REMOTE': '1', 07:21:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:21:23 INFO - 'NO_EM_RESTART': '1', 07:21:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:21:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:21:23 INFO - 'PWD': '/builds/slave/test', 07:21:23 INFO - 'SHELL': '/bin/bash', 07:21:23 INFO - 'SHLVL': '1', 07:21:23 INFO - 'TERM': 'linux', 07:21:23 INFO - 'TMOUT': '86400', 07:21:23 INFO - 'USER': 'cltbld', 07:21:23 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1472134252.930079-1383729287', 07:21:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:21:23 INFO - '_': '/tools/buildbot/bin/python'} 07:21:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:21:23 INFO - Running setup.py (path:/tmp/pip-tJhS5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:21:24 INFO - Running setup.py (path:/tmp/pip-hOeCg6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:21:24 INFO - Running setup.py (path:/tmp/pip-8Grs9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:21:24 INFO - Running setup.py (path:/tmp/pip-HT9fVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:21:24 INFO - Running setup.py (path:/tmp/pip-5Ovzly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:21:24 INFO - Running setup.py (path:/tmp/pip-yA7D75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:21:24 INFO - Running setup.py (path:/tmp/pip-27oVno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:21:24 INFO - Running setup.py (path:/tmp/pip-U8uqJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:21:24 INFO - Running setup.py (path:/tmp/pip-v9Tb69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:21:24 INFO - Running setup.py (path:/tmp/pip-Y4i5vb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:21:24 INFO - Running setup.py (path:/tmp/pip-lWGS40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:21:24 INFO - Running setup.py (path:/tmp/pip-39rIeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:21:24 INFO - Running setup.py (path:/tmp/pip-nOz8zb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:21:24 INFO - Running setup.py (path:/tmp/pip-kYM70p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:21:24 INFO - Running setup.py (path:/tmp/pip-4ve2RI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:21:25 INFO - Running setup.py (path:/tmp/pip-px7c3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:21:25 INFO - Running setup.py (path:/tmp/pip-Yzpaev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:21:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:21:25 INFO - Running setup.py install for manifestparser 07:21:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:21:25 INFO - Running setup.py install for mozcrash 07:21:25 INFO - Running setup.py install for mozdebug 07:21:25 INFO - Running setup.py install for mozdevice 07:21:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:21:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:21:25 INFO - Running setup.py install for mozfile 07:21:25 INFO - Running setup.py install for mozhttpd 07:21:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:21:25 INFO - Running setup.py install for mozinfo 07:21:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:21:25 INFO - Running setup.py install for mozInstall 07:21:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:21:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:21:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:21:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:21:25 INFO - Running setup.py install for mozleak 07:21:26 INFO - Running setup.py install for mozlog 07:21:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:21:26 INFO - Running setup.py install for moznetwork 07:21:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:21:26 INFO - Running setup.py install for mozprocess 07:21:26 INFO - Running setup.py install for mozprofile 07:21:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:21:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:21:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:21:26 INFO - Running setup.py install for mozrunner 07:21:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:21:26 INFO - Running setup.py install for mozscreenshot 07:21:26 INFO - Running setup.py install for moztest 07:21:26 INFO - Running setup.py install for mozversion 07:21:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:21:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:21:26 INFO - Cleaning up... 07:21:26 INFO - Return code: 0 07:21:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:21: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')]} 07:21:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:21:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21: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')]} 07:21:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:21:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21: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 0x7fa80b58ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d3230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cd090>, '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 0x19d09b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d0e40>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1472134252.930079-1383729287', '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 07:21: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 07:21: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 07:21:26 INFO - Using env: {'DISPLAY': ':0', 07:21:26 INFO - 'HOME': '/home/cltbld', 07:21:26 INFO - 'LANG': 'en_US.UTF-8', 07:21:26 INFO - 'LANGUAGE': 'en_US:en', 07:21:26 INFO - 'LOGNAME': 'cltbld', 07:21:26 INFO - 'MAIL': '/var/mail/cltbld', 07:21:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:21:26 INFO - 'MOZ_NO_REMOTE': '1', 07:21:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:21:26 INFO - 'NO_EM_RESTART': '1', 07:21:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:21:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:21:26 INFO - 'PWD': '/builds/slave/test', 07:21:26 INFO - 'SHELL': '/bin/bash', 07:21:26 INFO - 'SHLVL': '1', 07:21:26 INFO - 'TERM': 'linux', 07:21:26 INFO - 'TMOUT': '86400', 07:21:26 INFO - 'USER': 'cltbld', 07:21:26 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1472134252.930079-1383729287', 07:21:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:21:26 INFO - '_': '/tools/buildbot/bin/python'} 07:21:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:21:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:21:27 INFO - Running setup.py (path:/tmp/pip-u1kM8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:21:27 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)) 07:21:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:21:27 INFO - Running setup.py (path:/tmp/pip-U9FtPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:21:27 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)) 07:21:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:21:27 INFO - Running setup.py (path:/tmp/pip-7N2hSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:21:27 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)) 07:21:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:21:27 INFO - Running setup.py (path:/tmp/pip-ElDEB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:21:27 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)) 07:21:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:21:27 INFO - Running setup.py (path:/tmp/pip-DadBzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:21: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)) 07:21:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:21:27 INFO - Running setup.py (path:/tmp/pip-LWaXqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:21: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)) 07:21:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:21:27 INFO - Running setup.py (path:/tmp/pip-PjLAOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:21: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)) 07:21:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:21:27 INFO - Running setup.py (path:/tmp/pip-RK6oMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:21: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)) 07:21:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:21:27 INFO - Running setup.py (path:/tmp/pip-L4isXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:21: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)) 07:21:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:21:27 INFO - Running setup.py (path:/tmp/pip-xxqZlN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:21: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)) 07:21:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:21:27 INFO - Running setup.py (path:/tmp/pip-v3rz6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:21: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)) 07:21:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:21:27 INFO - Running setup.py (path:/tmp/pip-14Ufrd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:21:28 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)) 07:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:21:28 INFO - Running setup.py (path:/tmp/pip-sva5e9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:21:28 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)) 07:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:21:28 INFO - Running setup.py (path:/tmp/pip-pMlihd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:21:28 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)) 07:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:21:28 INFO - Running setup.py (path:/tmp/pip-bIh5R0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:21:28 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)) 07:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:21:28 INFO - Running setup.py (path:/tmp/pip-sxMxDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:21:28 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)) 07:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:21:28 INFO - Running setup.py (path:/tmp/pip-rJaV4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:21:28 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)) 07:21:28 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)) 07:21:28 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)) 07:21:28 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)) 07:21:28 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)) 07:21:28 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)) 07:21:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:21:28 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 07:21:28 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 07:21:28 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 07:21:28 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 07:21:28 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 07:21:28 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 07:21:30 INFO - Downloading blessings-1.6.tar.gz 07:21:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:21:30 INFO - Installing collected packages: blessings 07:21:30 INFO - Running setup.py install for blessings 07:21:30 INFO - Successfully installed blessings 07:21:30 INFO - Cleaning up... 07:21:30 INFO - Return code: 0 07:21:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:21:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:21:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:21:30 INFO - Reading from file tmpfile_stdout 07:21:30 INFO - Current package versions: 07:21:30 INFO - argparse == 1.2.1 07:21:30 INFO - blessings == 1.6 07:21:30 INFO - blobuploader == 1.2.4 07:21:30 INFO - docopt == 0.6.1 07:21:30 INFO - functools32 == 3.2.3-2 07:21:30 INFO - jsonschema == 2.5.1 07:21:30 INFO - manifestparser == 1.1 07:21:30 INFO - mozInstall == 1.12 07:21:30 INFO - mozcrash == 0.17 07:21:30 INFO - mozdebug == 0.1 07:21:30 INFO - mozdevice == 0.48 07:21:30 INFO - mozfile == 1.2 07:21:30 INFO - mozhttpd == 0.7 07:21:30 INFO - mozinfo == 0.9 07:21:30 INFO - mozleak == 0.1 07:21:30 INFO - mozlog == 3.3 07:21:30 INFO - moznetwork == 0.27 07:21:30 INFO - mozprocess == 0.23 07:21:30 INFO - mozprofile == 0.28 07:21:30 INFO - mozrunner == 6.12 07:21:30 INFO - mozscreenshot == 0.1 07:21:30 INFO - mozsystemmonitor == 0.3 07:21:30 INFO - moztest == 0.7 07:21:30 INFO - mozversion == 1.4 07:21:30 INFO - psutil == 3.1.1 07:21:30 INFO - requests == 1.2.3 07:21:30 INFO - wsgiref == 0.1.2 07:21:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:21: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')]} 07:21:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:21:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21: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')]} 07:21:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:21:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21: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 0x7fa80b58ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d3230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cd090>, '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 0x19d09b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d0e40>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1472134252.930079-1383729287', '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 07:21: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 07:21: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 07:21:30 INFO - Using env: {'DISPLAY': ':0', 07:21:30 INFO - 'HOME': '/home/cltbld', 07:21:30 INFO - 'LANG': 'en_US.UTF-8', 07:21:30 INFO - 'LANGUAGE': 'en_US:en', 07:21:30 INFO - 'LOGNAME': 'cltbld', 07:21:30 INFO - 'MAIL': '/var/mail/cltbld', 07:21:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:21:30 INFO - 'MOZ_NO_REMOTE': '1', 07:21:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:21:30 INFO - 'NO_EM_RESTART': '1', 07:21:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:21:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:21:30 INFO - 'PWD': '/builds/slave/test', 07:21:30 INFO - 'SHELL': '/bin/bash', 07:21:30 INFO - 'SHLVL': '1', 07:21:30 INFO - 'TERM': 'linux', 07:21:30 INFO - 'TMOUT': '86400', 07:21:30 INFO - 'USER': 'cltbld', 07:21:30 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1472134252.930079-1383729287', 07:21:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:21:30 INFO - '_': '/tools/buildbot/bin/python'} 07:21:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:21: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)) 07:21: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)) 07:21: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)) 07:21: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)) 07:21: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)) 07:21: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)) 07:21: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)) 07:21: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)) 07:21: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)) 07:21: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)) 07:21: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)) 07:21:30 INFO - Cleaning up... 07:21:30 INFO - Return code: 0 07:21:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:21: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')]} 07:21:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:21:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21: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')]} 07:21:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:21:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21: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 0x7fa80b58ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19d3230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cd090>, '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 0x19d09b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d0e40>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1472134252.930079-1383729287', '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 07:21: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 07:21: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 07:21:30 INFO - Using env: {'DISPLAY': ':0', 07:21:30 INFO - 'HOME': '/home/cltbld', 07:21:30 INFO - 'LANG': 'en_US.UTF-8', 07:21:30 INFO - 'LANGUAGE': 'en_US:en', 07:21:30 INFO - 'LOGNAME': 'cltbld', 07:21:30 INFO - 'MAIL': '/var/mail/cltbld', 07:21:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:21:30 INFO - 'MOZ_NO_REMOTE': '1', 07:21:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:21:30 INFO - 'NO_EM_RESTART': '1', 07:21:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:21:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:21:30 INFO - 'PWD': '/builds/slave/test', 07:21:30 INFO - 'SHELL': '/bin/bash', 07:21:30 INFO - 'SHLVL': '1', 07:21:30 INFO - 'TERM': 'linux', 07:21:30 INFO - 'TMOUT': '86400', 07:21:30 INFO - 'USER': 'cltbld', 07:21:30 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1472134252.930079-1383729287', 07:21:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:21:30 INFO - '_': '/tools/buildbot/bin/python'} 07:21:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:21:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:21:31 INFO - Cleaning up... 07:21:31 INFO - Return code: 0 07:21:31 INFO - Running post-action listener: _resource_record_post_action 07:21:31 INFO - Running post-action listener: _start_resource_monitoring 07:21:31 INFO - Starting resource monitoring. 07:21:31 INFO - [mozharness: 2016-08-25 14:21:31.220398Z] Finished create-virtualenv step (success) 07:21:31 INFO - [mozharness: 2016-08-25 14:21:31.220864Z] Running install step. 07:21:31 INFO - Running pre-action listener: _resource_record_pre_action 07:21:31 INFO - Running main action method: install 07:21:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:21:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:21:31 INFO - Reading from file tmpfile_stdout 07:21:31 INFO - Detecting whether we're running mozinstall >=1.0... 07:21:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:21:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:21:31 INFO - Reading from file tmpfile_stdout 07:21:31 INFO - Output received: 07:21:31 INFO - Usage: mozinstall [options] installer 07:21:31 INFO - Options: 07:21:31 INFO - -h, --help show this help message and exit 07:21:31 INFO - -d DEST, --destination=DEST 07:21:31 INFO - Directory to install application into. [default: 07:21:31 INFO - "/builds/slave/test"] 07:21:31 INFO - --app=APP Application being installed. [default: firefox] 07:21:31 INFO - mkdir: /builds/slave/test/build/application 07:21: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'] 07:21: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 07:21:48 INFO - Reading from file tmpfile_stdout 07:21:48 INFO - Output received: 07:21:48 INFO - /builds/slave/test/build/application/firefox/firefox 07:21:48 INFO - Running post-action listener: _resource_record_post_action 07:21:48 INFO - [mozharness: 2016-08-25 14:21:48.221298Z] Finished install step (success) 07:21:48 INFO - [mozharness: 2016-08-25 14:21:48.221635Z] Running run-tests step. 07:21:48 INFO - Running pre-action listener: _resource_record_pre_action 07:21:48 INFO - Running main action method: run_tests 07:21:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:21:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:21:48 INFO - Python 2.7.3 07:21:48 INFO - Return code: 0 07:21:48 INFO - grabbing minidump binary from tooltool 07:21: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')]} 07:21: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 0x19cd090>, '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 0x19d09b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19d0e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:21: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 07:21: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 07:21: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 07:21:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:21:48 INFO - Return code: 0 07:21:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:21:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:21:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:21:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:21:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:21:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DrZF3wgaT3aReiDHmNm8Ow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 07:21:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DrZF3wgaT3aReiDHmNm8Ow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --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 07:21:48 INFO - Using env: {'DISPLAY': ':0', 07:21:48 INFO - 'HOME': '/home/cltbld', 07:21:48 INFO - 'LANG': 'en_US.UTF-8', 07:21:48 INFO - 'LANGUAGE': 'en_US:en', 07:21:48 INFO - 'LOGNAME': 'cltbld', 07:21:48 INFO - 'MAIL': '/var/mail/cltbld', 07:21:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:21:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:21:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:21:48 INFO - 'MOZ_NO_REMOTE': '1', 07:21:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:21:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:21:48 INFO - 'NO_EM_RESTART': '1', 07:21:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:21:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:21:48 INFO - 'PWD': '/builds/slave/test', 07:21:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:21:48 INFO - 'SHELL': '/bin/bash', 07:21:48 INFO - 'SHLVL': '1', 07:21:48 INFO - 'TERM': 'linux', 07:21:48 INFO - 'TMOUT': '86400', 07:21:48 INFO - 'USER': 'cltbld', 07:21:48 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1472134252.930079-1383729287', 07:21:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:21:48 INFO - '_': '/tools/buildbot/bin/python'} 07:21:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DrZF3wgaT3aReiDHmNm8Ow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 07:21:48 INFO - mozversion application_buildid: 20160825060025 07:21:48 INFO - mozversion application_changeset: 7963ebdd52b93f96b812eff2eab8d94097147b9c 07:21:48 INFO - mozversion application_display_name: Nightly 07:21:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:21:48 INFO - mozversion application_name: Firefox 07:21:48 INFO - mozversion application_remotingname: firefox 07:21:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:21:48 INFO - mozversion application_vendor: Mozilla 07:21:48 INFO - mozversion application_version: 51.0a1 07:21:48 INFO - mozversion platform_buildid: 20160825060025 07:21:48 INFO - mozversion platform_changeset: 7963ebdd52b93f96b812eff2eab8d94097147b9c 07:21:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:21:48 INFO - mozversion platform_version: 51.0a1 07:21:48 INFO - using testdate: 1472134908 07:21:48 INFO - actual date: 1472134908 07:21:48 INFO - starting webserver on 'localhost:56814' 07:21:48 INFO - SUITE-START | Running 2 tests 07:21:48 INFO - TEST-START | dromaeo_css 07:21:48 INFO - operating with platform_type : linux_ 07:21:48 INFO - Initialising browser for dromaeo_css test... 07:21:48 INFO - TEST-INFO | started process 6108 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFjkZHd/profile http://localhost:56814/getInfo.html) 07:21:52 INFO - PROCESS | 6108 | __metrics Screen width/height:1600/1200 07:21:52 INFO - PROCESS | 6108 | colorDepth:24 07:21:52 INFO - PROCESS | 6108 | Browser inner width/height: 1024/697 07:21:52 INFO - PROCESS | 6108 | __metrics 07:21:53 INFO - PROCESS | 6108 | 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" 07:21:53 INFO - PROCESS | 6108 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:21:54 INFO - PROCESS | 6108 | console.error: PushService: 07:21:54 INFO - PROCESS | 6108 | stateChangeProcessEnqueue: Error transitioning state 07:21:54 INFO - PROCESS | 6108 | UnknownError 07:21:54 INFO - TEST-INFO | 6108: exit 0 07:21:54 INFO - Browser initialized. 07:21:54 INFO - Running cycle 1/1 for dromaeo_css test... 07:21:54 INFO - TEST-INFO | started process 6193 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFjkZHd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:22:07 INFO - PROCESS | 6193 | RSS: Main: 179638272 07:22:07 INFO - PROCESS | 6193 | 07:22:58 INFO - PROCESS | 6193 | 1472134978151 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] 07:25:11 INFO - PROCESS | 6193 | Cycle 1(1): loaded http://localhost:56814/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56814/tests/dromaeo/cssquery-ext.html) 07:25:12 INFO - PROCESS | 6193 | RSS: Main: 264978432 07:25:12 INFO - PROCESS | 6193 | 07:28:15 INFO - PROCESS | 6193 | Cycle 1(1): loaded http://localhost:56814/tests/dromaeo/cssquery-ext.html (next: http://localhost:56814/tests/dromaeo/cssquery-jquery.html) 07:28:15 INFO - PROCESS | 6193 | RSS: Main: 277069824 07:28:15 INFO - PROCESS | 6193 | 07:31:17 INFO - PROCESS | 6193 | Cycle 1(1): loaded http://localhost:56814/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56814/tests/dromaeo/cssquery-mootools.html) 07:31:18 INFO - PROCESS | 6193 | RSS: Main: 215764992 07:31:18 INFO - PROCESS | 6193 | 07:34:20 INFO - PROCESS | 6193 | Cycle 1(1): loaded http://localhost:56814/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56814/tests/dromaeo/cssquery-prototype.html) 07:34:21 INFO - PROCESS | 6193 | RSS: Main: 278085632 07:34:21 INFO - PROCESS | 6193 | 07:37:24 INFO - PROCESS | 6193 | Cycle 1(1): loaded http://localhost:56814/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56814/tests/dromaeo/cssquery-yui.html) 07:37:25 INFO - PROCESS | 6193 | RSS: Main: 215920640 07:37:25 INFO - PROCESS | 6193 | 07:40:28 INFO - PROCESS | 6193 | Cycle 1(1): loaded http://localhost:56814/tests/dromaeo/cssquery-yui.html (next: http://localhost:56814/tests/dromaeo/cssquery-dojo.html) 07:40:28 INFO - PROCESS | 6193 | RSS: Main: 306663424 07:40:28 INFO - PROCESS | 6193 | 07:40:28 INFO - PROCESS | 6193 | __start_tp_report 07:40:28 INFO - PROCESS | 6193 | _x_x_mozilla_page_load 07:40:28 INFO - PROCESS | 6193 | _x_x_mozilla_page_load_details 07:40:28 INFO - PROCESS | 6193 | |i|pagename|runs| 07:40:28 INFO - PROCESS | 6193 | |0;dojo.html;2555.552778263804;2560.1807421625062;2576.0339872547793;2578.9871050644742;2597.7791887689546;4517.796699148538;4579.465151725093;4608.5161058088925;4643.466001409839;4723.90552188956;4579.4046773919345;4588.105319462706;4604.516525764797;4639.489656137822;4710.199266124759;4231.322988321869;4243.681723870706;4251.532331443539;4251.787410629471;4375.08123294107;4285.164392943378;4322.265214913472;4355.6515478761785;4370.6503479721705;4373.081652852905;4154.709170358076;4288.421063156465;4332.7400355978425;4336.609705126538;4358.825646974117;4186.6859985500905;4216.704830661855;4251.59609837065;4257.382679511485;4270.039241170743;4223.0709243966585;4231.217224813388;4287.678424118204;4292.720973136736;4296.9140617187795;4665.231922722156;4687.601553867891;4690.413698287714;4690.882727931795;4726.692764970266;4786.856394308142;4958.9008219835405;5011.649184557083;5014.5737612303;5030.5221004004925;5042.974785126087;5050.141475949097;5055.388518744191;5061.291419201315;5081.187010078406;4505.887352816206;4723.504032076583;4731.929021064687;4732.810687572527;4733.763311834464;5030.396352437658;5054.09026375256;5057.190849464068;5066.594672426197;5143.922841157386;4855.5387238212315;4862.562369386772;4867.586255168279;4868.342773725572;4919.262110683355;4835.057163853015;4957.058158949788;4967.05625931072;4968.801247950041;5022.673526220784;4806.591439727592;4834.564889159992;4839.830605928775;4895.6083513318845;4912;4834.057358815067;4840.540148685869;4841.3222148899185;4852.927206091911;4899.461059283476;4199.811008504625;4202.222588821078;4205.0959043805115;4208.116295577902;4249.277622804131;3643.690286325639;3658.9634103659155;3701.833417496165;3707.295613833363;3735.1782607826235;4344.044310251739;4344.500382455994;4393.956060439355;4402.053558484877;4404.031113155101;5039.874003149951;5043.218301163325;5047.116754567936;5052.8484145475695;5118.923216151761;4185.686073544496;4247.256730072225;4257.340112282539;4340.934885976713;4347.652187824967;4469.262571675637;4489.214387482178;4531.161735079021;4532.093581283756;4552.408186935743;4667.696599721007;4669.883252918568;4670.696404733681;4672.95327046732;4730.006698593334;4779.880502987453;4960.925586116284;4966.701997880139;4974;5019.573336266459;4721.693089949143;4743.644226683082;4745.881352966204;4779.283107533898;4797.832075877328;4934.654574179916;4940.851774446773;4941.555260026615;4943.65394422387;5000.874978125576;4862.610991120631;4917.5328343808715;4925.38432695913;5016.172331565251;5070.847874563769;4787.210110331756;4814.422269327703;4814.446338670958;4834.854954351375;4902.509749025069;4831.154547954024;4833.10587541306;4834.250691142878;4835.274708793709;4900.191468407673;4685.8594242172785;4777.355057067391;4785.066911952275;4789.808407663654;4848.006158737521;4831.806727730851;4868.075065737498;4883.682560633548;4900.068986892479;4962.032403681247;4774.594159496482;4777.546133117348;4780.2829575562555;4786.976065119652;4837.298591704253 07:40:28 INFO - PROCESS | 6193 | |1;ext.html;553.2973124132352;566.9766072239609;570.5977286013361;572.2617823008319;572.997135014325;28342.14973550794;38681.419778703304;40335.596644033554;40430.19139617209;43549.12901741963;39403.605963940354;39766;39900.401493977544;39917;39974.40038399426;7575.393968482522;7721.22787721229;7728.961355193216;7730.111037230734;7731.149573546905;7647.885281720779;7736.226377362275;7742.032245969254;7742.690292388298;7745.419093568005;7709.1134519530415;7732.342750866183;7754.340881025119;7758;7760;7711.498752581064;7747.109082455477;7749.845003099963;7751.147373788879;7756.922430775733;7633.427492938052;7663.27198916102;7682.692692292301;7694.846103077963;7695.961520192419;37596.43605345922;37835.24329513394;37863.81068094642;37957.620423795684;38089;2978.9851050744605;3132.1699749566383;3194.073718621597;3400.4559270516847;3418.8632454701783;28562.143135705963;28904.71095289041;29049.273768155756;29183;29285.853570732223;3163.4938409854544;3225.6774322567558;3265.853036613358;3368.2758206985613;3378.341223461426;242039;242380;243142;243290;243784;31113;50659.746701266995;51143.488565113876;51241.48758512367;51273;31528.527072093937;33332.16669583231;33337.833310833776;33354.49968250478;33369.165770855434;12965.416556254992;13091.541796037283;13092.214467132002;13093.607191784262;13098.083134180515;9898.554565044591;9974.950125249326;10063.798724025479;10077.949610251902;10084.949575252223;7663.348615367645;7748.380129589619;7802.414818888606;7806.765797026098;7811.336036436966;3006.774491913115;3047.2686555226587;3068.2022674104446;3085.691430856896;3095.907122786275;831.9542425166553;866.9436486628349;875.3216257400566;876.6712482818942;886.2909672262165;27412.862935685192;28303.71696283052;28376.71623283782;29078.854605726836;29094.563581546292;932.7854593443546;952.0717300631828;967.7241986033946;977.6529332087149;1014.523174108168;14154.36305366261;14871.256437178097;15188.316525756367;15289.694206115815;15415.997960132556;376888;381287;381352;381952;383846;47897.281540776916;48727.269090963666;48859.755701221264;48901;48912.75543622259;1035.35807799165;1132.6941725734005;1190.8570971483305;1192.3680449361852;1194.8924596786158;26861.462770744867;27909.860450697615;28069;28982.855085724437;30254;45764.771176143906;46438;46461;46504.7674761624;46516.30225546687;338827;342458;342914;343359;344181;30145.397092058476;38268.234635307694;38514.229715404974;40207.396889047275;40936.59063409447;40916.590834092465;41433;41679.1664166721;41766.79116604398;42376.78811605922;35470.290594187456;35474.290514190085;35591.64408355987;35781.64218357887;36404.81797590995;35177.64822351846;35759;35822;35923.82038089793;36296;34104.829475852464;34337.828310858284;34758;34780.82609586936;35012.47481287834;30364.84817575898;32881.506777398834;33025.33949321048;33036.50445243371;33085.33829323352;24736.752632473446;25031.49937001286;25272.241832745047;25554.488910222062;25694.87152564225 07:40:28 INFO - PROCESS | 6193 | |2;jquery.html;358.8761877152383;373.49764566657853;374.92688925659496;382.89087610031146;397.3265315290582;15989.120598367084;17216.225269862854;17837.894328242335;17923.46229613112;18093.1858066387;15933.01766491041;17250.39623613174;17396.39112631058;17425.390111346107;17514.82485175148;4868.196747536661;5124.231365295198;5129.666571672848;5132.101882170605;5135.075686376451;5068.974655126719;5124.333836601255;5149.227615857632;5349.063913815066;5369.785208591652;5456.61803673743;5509.696966666832;5520.91718624221;5522.530584900288;5526.364468086162;5267.947320526784;5350.438203988583;5371.274877891474;5376.489233522809;5529.3364796224505;5164.793408263665;5174.741262936838;5190.558802501791;5197.870053248661;5204.687718736888;14251;14511.70976580473;20845.270415535382;20896.791032089637;20974.700186461738;1840.8494690818238;1917.4151883675474;1932.4106147624968;1934.6614342490009;1976.160131943918;9282;9424.387414818015;9448.149666530046;9897.505124743806;9937;1712.8715346349074;1750.3873644224548;1764.3560100563202;1791.167107295114;1795.1383335998664;62453;69495.65252173757;69836.30163698399;71221.64389178072;71803;10022.498875056219;10284.691459256233;10340.431276279727;10439.791204175874;10466.162706983423;13657.590272291847;13664.521741738992;14053.718925621635;14073.296335183404;14104.294785260696;5929.703514824241;5992.250968628921;6487.935120648827;7249.746258880914;7452.441066919894;6856.897146542806;6890.31096890307;7077.681504332318;7087.964560177269;7168.211496735355;3964.2467931093;4318.827246910088;7799.45403821727;8322.583870806435;8334.458260213189;2978.8510574471625;2998.3165067265113;3101.9689803102133;3367.74741894354;3439.3121375724454;756.3306473770753;821.5029906906356;831.7338451695521;890.7327801659605;903.9819203615891;17042.23309951055;17050.74423883643;17885.28458861631;18283.360082397317;18594.628107437777;765.2309429023907;826.2522417212432;848.5672307123289;872.7905302727427;882.8278485695228;9276.582553785096;9920.553575089138;9985.900140998498;9997.800043999225;10026.949865250626;141427;141551.29224354017;141672.29163854115;142174;144361.27819360836;59546.40453595495;70493.647531762;72106;81584.59207704042;82732;902.309733054214;908.2098574240453;948.4451595816387;950.0736781637986;950.5294879034922;15784.684306314039;16161.838381616033;16327.346906123623;17076.23156957915;17162.141892905056;37635.24729505449;38199;38254.40947086368;38464.230715384976;39035.21929561449;51980.480195199074;52276.73861630668;53119;53448.465515344345;53931.73034134804;6784;7014.929850701427;7094.503384763224;7263.237360077116;7415.962920185365;9595.712128636153;11748.118891083373;11919.642410727693;12133.939330303292;12522.937385313015;10065.849012264676;10222.897771022492;10253.179745620184;10646.148308135485;10823.618803863137;10274.434906080238;10647;10721.839172412265;10759.75074548495;10873.565057397933;9788;9844.2124630028;10170.745731356776;10771.13830893511;10830;7062.3996960258955;7213.963930180315;7285.672144753605;7353.411727061715;7478.925210748041;9877.259205559756;9962.402255864672;10011.349262297927;10111.39331640104;10609.734756631146 07:40:28 INFO - PROCESS | 6193 | |3;mootools.html;1373.457484293704;1388.5140200929675;1437.2741765408466;1607.4936395035563;1631.2822358162416;6588.53880228383;7129.180144283409;7267.454940879429;7765.49524280922;7772.4170687198475;7430.256974302567;7637.312641862231;7661.578613176273;7675.194104619019;7692;2161.5892980333724;2188.627933251343;2191.123550579765;2192.5943700415396;2194.5501172259646;1816.8455681267042;2080.9687854682193;2126.234555560005;2155.6012137754487;2171.413718296059;2137.326742076241;2155.374941267031;2169.6853956176346;2169.8806565638884;2169.913203471859;2121.8090371866606;2124.1821898569083;2145.184829764695;2149.118861266889;2153.192552792703;2134.7971942665577;2145.2706079932896;2154.7737487563736;2160.25471212433;2171.16410182081;7899.249571290718;7961.36309095271;7966.880496792553;7980.760577182694;7981.880271795928;4478.462584489849;4651.279051746951;4655.092257009885;4666.066786642651;4667.043256132519;2870.626818513601;2926.88292468301;2998.9550156747664;3000.3999200160056;3037.726604605574;906.3610154840821;937.3017102258792;957.1672644798999;960.9375390599658;970.9805803883953;9653.855192172123;9901.603935842557;10076.798464030679;10510.894891051068;10520.210984176141;4103.528094269138;4228.344606585984;4288.31386978082;4357.912841743211;4381.671374646914;8258;8259.091499935003;8259.174082591813;8264;8269.46248493846;4582.977085114553;4616.261398176276;4629.282461218517;4660.04469083837;4667.463241727245;4168.478940132483;4240.088380998101;4256.127493863751;4259.297215959394;4262.893427664271;3247.2693643930397;3355.5973283205685;3378.797272163678;3405.216800135983;3428.9485657715154;904.3127223310331;1008.349614498659;1018.1956254558963;1062.054771253585;1066.1630619963291;836.1178956201145;837.8676268895675;843.1442086282428;851.8159757936473;876.5923845411914;5201.479852014768;5308.814191503356;5425.647332923348;5427.375851777097;5474.890502189934;858.2576071698061;861.9742506417343;878.9956050219708;888.0852721696534;911.2345629671108;3577.0878426001204;3607.404778211618;3656.2504686539196;3670.834812433447;3805.9429108563395;9548.42709437436;9658.951705241428;9809.166220871162;9950.452725100044;9966.352187107816;9825.213982881352;9825.4104753715;9831.950840245752;9831.950840245896;9835.704928852147;7388.556686598821;7421.888671669929;7455.440841936768;7457.216992215847;7505.699772009168;5271.736413179249;5307.601929855199;5344.946550534601;5410.431904650112;5486.972565137149;8964.238039766433;9054.27565794748;9055.18503334703;9176.128267814547;9181.311401645036;8851.46891186531;8890.555472226491;8947.418417802823;8988.146126118008;9075.319351048565;6889.793306200822;6967.8606427870145;6994.405475534637;7010.193827709879;7067.858642827217;7585.279398457138;7610.238976102345;7647.235276472308;7648.273414025659;7649.694012239448;6773.119494465688;6827.863442731018;6878.037074809631;6890.44876409876;7001.264867188872;6770.763023294161;6798.490113241428;6820.965895170492;6860.176778786577;6866.793996180123;6393.136926515047;6413.935860641521;6436;6456.418922297016;6533.640649764308;4534.478534968389;4592.196365636067;4669.136209801198;4823.252395878644;4825.10735513931;4644.2801365788355;4732.716037037789;4846.80612775485;4867.1969125093965;4933.038057578738 07:40:28 INFO - PROCESS | 6193 | |4;prototype.html;273.1069403052019;293.8002158532197;294.90120809528804;301.7269371219047;303.17385125532917;4514.525974772642;4627.421572303462;4705.905881882364;4751.8574442766685;4757.0723708876785;4652.371929789478;4652.7906244219;4677.719336839792;4696.906061878761;4730.337752714614;3770.2271034438013;3777.8666400080006;3780.640839120279;3780.6786423153926;3790.2987947229713;3548.2903419316112;3595.7842529448185;3773.3585290500682;3790.8294126764363;3795.392737162055;3705.8147092645395;3713;3722.702183825301;3724.7020238381;3729.5710993235716;3720.330340538702;3722.5346831645907;3724.7392682512236;3726.962730372689;3733.4399840023943;3313.453280208763;3313.8625586496573;3317.4360358739073;3318.3574130805164;3323.7839540430036;4419.558044195587;4587.8666420114805;4588.862334129982;4605.516420775803;4627.444706635191;4218.578142185757;4244.745315281062;4249.618873866006;4255.1915136124035;4259.339802330613;4800.591949684281;4916.729579873106;4923.655344125913;4923.679960802572;4931.457539670633;3515.2442224921765;3524.718022558189;3528.7882727036204;3532.717382609385;3534.505169276303;5141.640085194038;5176.301199338079;5177.792888284502;5184.326037615086;5193.350831146145;3609.097725568608;3610.9638903611153;3617.7286703497343;3622.185008373095;3629.4737263096704;3446.4141096013736;3650.945235821465;3664.157243833933;3677.9264414711556;3697.149655579178;4183.45615070045;4185.790710464465;4188.476440444944;4191.8742437726305;4191.874243772691;4993.625478089158;5002.324686167321;5034.11902916988;5057.190849464068;5058.721770302669;1199.9020895880346;1234.3211233821542;1268.5877089945805;1276.8850803427736;1288.5168061976758;841.8442588121217;864.1444969480295;866.5883705239961;867.3494878840869;875.8335916175906;4327.7186982846015;4336.197803406317;4355.716878402957;4365.607095361433;4376.803043863034;5054.898902022012;5061.544460998528;5074.264231686385;5078.847634570969;5079.060373830853;4351.26028575143;4372.934405983913;4382.737035777864;4383.868483945486;4384.802683879233;2311.306608017622;2404.891779869875;2408.6989126359204;2430.258771074804;2434.2210492642184;4191.664666826647;4240.279152544075;4246.72396294246;4273.316269396943;4297.699161058696;4558.247889098328;4570.88572785683;4608.584912727531;4608.700434471749;4614.946348874719;4125.958740412618;4171.561985991488;4266.954596123969;4269.40228368035;4307.569243075667;4504.166729155117;4508.684392092522;4525.683202175947;4537.364768932418;4548.317752337043;4414.139242847614;4425.672298310558;4447;4460.483435631901;4473.217186992329;4251.917359914038;4253.383259427427;4293.935590966201;4483.506814250495;4857.95142048575;3641.1443310821405;3653.963460365362;3656.762310449812;3670.3209906167444;3674.669279764834;5092.7199004053655;5103.928175083274;5113.346854362512;5131.615128865425;5133.897322053613;4746;4819.807207711652;4918.360613120271;4951.72765497901;4955.182394904945;4955.82654607087;4967.82612608557;4975.601951843916;4975.880426903917;4979.203327467588;4908.558229759339;4919.926201107058;4921.434035086011;4924.630652701134;4932.778024988956;4747.240441529339;4985.903101317705;4995.650304478651;4996.2505624156665;5003.324551185543;4881.536254055859;4888.364512613338;4889.828855990023;4919.704817710949;4925.605951523941 07:40:28 INFO - PROCESS | 6193 | |5;yui.html;627.5732501898709;675.9763408280708;677.355146017568;728.9325563356472;730.9890351644726;13468.595942121727;14390.424383024692;14504.129752214862;14531.200783956878;14578.635534111652;13349.332533373317;13526.18842869426;13532.052756307063;13532.120412173203;13543.796843047363;614.0788816774838;725.9491835571512;737.7307282841764;758.5069704691939;758.7647829172946;757.3978686943865;767.3860911270989;767.7965339185121;767.8042099264708;768.1511929318107;803.1125606205147;804.7263930263709;804.7344376355818;805.2149154574302;805.4160733468218;637.1621317966859;765.5291995422775;795.2445177081795;796.9721059762938;797.5254723439544;578.6788332475475;581.2327727399834;586.214472606709;586.2730214533947;586.5278450847067;12471.002319814394;12545.93727031359;12630.873691263061;12643.873561264361;12687.555935542305;11880.524779008829;12193.207441516362;12746.171498852545;12872.22766634005;13119.86880131196;11638.185327027111;11816.586419475363;11860.703482413008;12034.759304813855;12476.064295177806;3818.7517811342173;3897.6881849451975;3921.9215615687526;3929.5413209756753;4000.659943904772;66345;66396.33603663999;66449;66563;67195;9958.651447199458;10072.194224462171;10430.530626121843;10492;10499.68500944973;17530.12349382551;17669.20488578017;17712.291508339524;17754.556136096442;18211.817881821276;6583.539152259296;6592.077109204715;6612.669366531654;6687.899681504781;6807.0810440589885;3522.84147213376;3562.447820587813;3584.068142282973;3618.6743193112748;3689.963100368962;2675.1172113202597;2788.093869492423;2789.316617428743;2789.7768178545666;2790.4279622677304;476.15720175289545;481.70134516599234;481.86507777822266;484.3509697006029;532.1219987021445;580.5210701171466;616.5252755378334;618.2179542878263;620.8106527509153;620.8634100497883;8410.579471026547;8427.789305267417;8733.51965641883;8900.198982091513;9070.365074444857;554.276668947028;571.5856004396862;616.1527899138684;632.5445679111033;636.7803107927757;4153.54311025787;4187.811548480326;4227.957720422818;4254.212970600449;4320.481542214891;100448;100925;101655.4917225424;104639;105234;51621.426974942115;87805.56097219473;88379.4173961302;89216.5539172313;89753;45674.08651826945;60516.092258616154;65540.34459655438;71278;73106.63446682839;7784;7859.52842829432;7932.286094251545;7974.282314591715;8103.594820258845;44619.55380446284;44630.3305450412;44873.326900095875;45602.77198614118;46570.534294656616;57272.427275728376;66060.00909986258;67534.66232668805;67561;69772.651136744;9873.50632468388;9997.900020999698;10000.149987251165;10085.899141008496;10278.794424111626;10883.401412922365;10942.890571094187;11125.388103654377;11513.597024104116;11848.763024739284;9997.850032249376;11923.940380298043;11967.401629918644;11976.520939162336;12895.871041289467;11208.831867522156;11589;12081.395930203278;12321.075919306268;12382.504699812267;11817.290962542274;12002.459889304828;12044.457999390224;12286.201396909173;13271.402786874422;9838.803223935623;9885.110340069428;10387.37675739458;10581.576736930436;10593.735156621146;10064.949675251577;10385.792284154124;10581.682549523526;10679.359238445719;10731.141508679131 07:40:28 INFO - PROCESS | 6193 | __end_tp_report 07:40:28 INFO - PROCESS | 6193 | __start_cc_report 07:40:28 INFO - PROCESS | 6193 | _x_x_mozilla_cycle_collect,1133 07:40:28 INFO - PROCESS | 6193 | __end_cc_report 07:40:28 INFO - PROCESS | 6193 | __startTimestamp1472136028917__endTimestamp 07:40:28 INFO - PROCESS | 6193 | 07:40:28 INFO - PROCESS | 6193 | ------- Summary: start ------- 07:40:28 INFO - PROCESS | 6193 | Number of tests: 6 07:40:28 INFO - PROCESS | 6193 | 07:40:28 INFO - PROCESS | 6193 | [#0] dojo.html Cycles:165 Average:4599.45 Median:4743.64 stddev:481.87 (10.2%) stddev-sans-first:455.89 07:40:28 INFO - PROCESS | 6193 | Values: 2555.6 2560.2 2576.0 2579.0 2597.8 4517.8 4579.5 4608.5 4643.5 4723.9 4579.4 4588.1 4604.5 4639.5 4710.2 4231.3 4243.7 4251.5 4251.8 4375.1 4285.2 4322.3 4355.7 4370.7 4373.1 4154.7 4288.4 4332.7 4336.6 4358.8 4186.7 4216.7 4251.6 4257.4 4270.0 4223.1 4231.2 4287.7 4292.7 4296.9 4665.2 4687.6 4690.4 4690.9 4726.7 4786.9 4958.9 5011.6 5014.6 5030.5 5043.0 5050.1 5055.4 5061.3 5081.2 4505.9 4723.5 4731.9 4732.8 4733.8 5030.4 5054.1 5057.2 5066.6 5143.9 4855.5 4862.6 4867.6 4868.3 4919.3 4835.1 4957.1 4967.1 4968.8 5022.7 4806.6 4834.6 4839.8 4895.6 4912.0 4834.1 4840.5 4841.3 4852.9 4899.5 4199.8 4202.2 4205.1 4208.1 4249.3 3643.7 3659.0 3701.8 3707.3 3735.2 4344.0 4344.5 4394.0 4402.1 4404.0 5039.9 5043.2 5047.1 5052.8 5118.9 4185.7 4247.3 4257.3 4340.9 4347.7 4469.3 4489.2 4531.2 4532.1 4552.4 4667.7 4669.9 4670.7 4673.0 4730.0 4779.9 4960.9 4966.7 4974.0 5019.6 4721.7 4743.6 4745.9 4779.3 4797.8 4934.7 4940.9 4941.6 4943.7 5000.9 4862.6 4917.5 4925.4 5016.2 5070.8 4787.2 4814.4 4814.4 4834.9 4902.5 4831.2 4833.1 4834.3 4835.3 4900.2 4685.9 4777.4 4785.1 4789.8 4848.0 4831.8 4868.1 4883.7 4900.1 4962.0 4774.6 4777.5 4780.3 4787.0 4837.3 07:40:28 INFO - PROCESS | 6193 | 07:40:28 INFO - PROCESS | 6193 | [#1] ext.html Cycles:180 Average:46773.98 Median:36350.41 stddev:86365.00 (237.6%) stddev-sans-first:86537.55 07:40:28 INFO - PROCESS | 6193 | Values: 553.3 567.0 570.6 572.3 573.0 28342.1 38681.4 40335.6 40430.2 43549.1 39403.6 39766.0 39900.4 39917.0 39974.4 7575.4 7721.2 7729.0 7730.1 7731.1 7647.9 7736.2 7742.0 7742.7 7745.4 7709.1 7732.3 7754.3 7758.0 7760.0 7711.5 7747.1 7749.8 7751.1 7756.9 7633.4 7663.3 7682.7 7694.8 7696.0 37596.4 37835.2 37863.8 37957.6 38089.0 2979.0 3132.2 3194.1 3400.5 3418.9 28562.1 28904.7 29049.3 29183.0 29285.9 3163.5 3225.7 3265.9 3368.3 3378.3 242039.0 242380.0 243142.0 243290.0 243784.0 31113.0 50659.7 51143.5 51241.5 51273.0 31528.5 33332.2 33337.8 33354.5 33369.2 12965.4 13091.5 13092.2 13093.6 13098.1 9898.6 9975.0 10063.8 10077.9 10084.9 7663.3 7748.4 7802.4 7806.8 7811.3 3006.8 3047.3 3068.2 3085.7 3095.9 832.0 866.9 875.3 876.7 886.3 27412.9 28303.7 28376.7 29078.9 29094.6 932.8 952.1 967.7 977.7 1014.5 14154.4 14871.3 15188.3 15289.7 15416.0 376888.0 381287.0 381352.0 381952.0 383846.0 47897.3 48727.3 48859.8 48901.0 48912.8 1035.4 1132.7 1190.9 1192.4 1194.9 26861.5 27909.9 28069.0 28982.9 30254.0 45764.8 46438.0 46461.0 46504.8 46516.3 338827.0 342458.0 342914.0 343359.0 344181.0 30145.4 38268.2 38514.2 40207.4 40936.6 40916.6 41433.0 41679.2 41766.8 42376.8 35470.3 35474.3 35591.6 35781.6 36404.8 35177.6 35759.0 35822.0 35923.8 36296.0 34104.8 34337.8 34758.0 34780.8 35012.5 30364.8 32881.5 33025.3 33036.5 33085.3 24736.8 25031.5 25272.2 25554.5 25694.9 07:40:28 INFO - PROCESS | 6193 | 07:40:28 INFO - PROCESS | 6193 | [#2] jquery.html Cycles:180 Average:17509.35 Median:5124.28 stddev:27292.13 (532.6%) stddev-sans-first:27338.32 07:40:28 INFO - PROCESS | 6193 | Values: 358.9 373.5 374.9 382.9 397.3 15989.1 17216.2 17837.9 17923.5 18093.2 15933.0 17250.4 17396.4 17425.4 17514.8 4868.2 5124.2 5129.7 5132.1 5135.1 5069.0 5124.3 5149.2 5349.1 5369.8 5456.6 5509.7 5520.9 5522.5 5526.4 5267.9 5350.4 5371.3 5376.5 5529.3 5164.8 5174.7 5190.6 5197.9 5204.7 14251.0 14511.7 20845.3 20896.8 20974.7 1840.8 1917.4 1932.4 1934.7 1976.2 9282.0 9424.4 9448.1 9897.5 9937.0 1712.9 1750.4 1764.4 1791.2 1795.1 62453.0 69495.7 69836.3 71221.6 71803.0 10022.5 10284.7 10340.4 10439.8 10466.2 13657.6 13664.5 14053.7 14073.3 14104.3 5929.7 5992.3 6487.9 7249.7 7452.4 6856.9 6890.3 7077.7 7088.0 7168.2 3964.2 4318.8 7799.5 8322.6 8334.5 2978.9 2998.3 3102.0 3367.7 3439.3 756.3 821.5 831.7 890.7 904.0 17042.2 17050.7 17885.3 18283.4 18594.6 765.2 826.3 848.6 872.8 882.8 9276.6 9920.6 9985.9 9997.8 10026.9 141427.0 141551.3 141672.3 142174.0 144361.3 59546.4 70493.6 72106.0 81584.6 82732.0 902.3 908.2 948.4 950.1 950.5 15784.7 16161.8 16327.3 17076.2 17162.1 37635.2 38199.0 38254.4 38464.2 39035.2 51980.5 52276.7 53119.0 53448.5 53931.7 6784.0 7014.9 7094.5 7263.2 7416.0 9595.7 11748.1 11919.6 12133.9 12522.9 10065.8 10222.9 10253.2 10646.1 10823.6 10274.4 10647.0 10721.8 10759.8 10873.6 9788.0 9844.2 10170.7 10771.1 10830.0 7062.4 7214.0 7285.7 7353.4 7478.9 9877.3 9962.4 10011.3 10111.4 10609.7 07:40:28 INFO - PROCESS | 6193 | 07:40:28 INFO - PROCESS | 6193 | [#3] mootools.html Cycles:180 Average:5138.91 Median:5480.93 stddev:2856.59 (52.1%) stddev-sans-first:2850.59 07:40:28 INFO - PROCESS | 6193 | Values: 1373.5 1388.5 1437.3 1607.5 1631.3 6588.5 7129.2 7267.5 7765.5 7772.4 7430.3 7637.3 7661.6 7675.2 7692.0 2161.6 2188.6 2191.1 2192.6 2194.6 1816.8 2081.0 2126.2 2155.6 2171.4 2137.3 2155.4 2169.7 2169.9 2169.9 2121.8 2124.2 2145.2 2149.1 2153.2 2134.8 2145.3 2154.8 2160.3 2171.2 7899.2 7961.4 7966.9 7980.8 7981.9 4478.5 4651.3 4655.1 4666.1 4667.0 2870.6 2926.9 2999.0 3000.4 3037.7 906.4 937.3 957.2 960.9 971.0 9653.9 9901.6 10076.8 10510.9 10520.2 4103.5 4228.3 4288.3 4357.9 4381.7 8258.0 8259.1 8259.2 8264.0 8269.5 4583.0 4616.3 4629.3 4660.0 4667.5 4168.5 4240.1 4256.1 4259.3 4262.9 3247.3 3355.6 3378.8 3405.2 3428.9 904.3 1008.3 1018.2 1062.1 1066.2 836.1 837.9 843.1 851.8 876.6 5201.5 5308.8 5425.6 5427.4 5474.9 858.3 862.0 879.0 888.1 911.2 3577.1 3607.4 3656.3 3670.8 3805.9 9548.4 9659.0 9809.2 9950.5 9966.4 9825.2 9825.4 9832.0 9832.0 9835.7 7388.6 7421.9 7455.4 7457.2 7505.7 5271.7 5307.6 5344.9 5410.4 5487.0 8964.2 9054.3 9055.2 9176.1 9181.3 8851.5 8890.6 8947.4 8988.1 9075.3 6889.8 6967.9 6994.4 7010.2 7067.9 7585.3 7610.2 7647.2 7648.3 7649.7 6773.1 6827.9 6878.0 6890.4 7001.3 6770.8 6798.5 6821.0 6860.2 6866.8 6393.1 6413.9 6436.0 6456.4 6533.6 4534.5 4592.2 4669.1 4823.3 4825.1 4644.3 4732.7 4846.8 4867.2 4933.0 07:40:28 INFO - PROCESS | 6193 | 07:40:28 INFO - PROCESS | 6193 | [#4] prototype.html Cycles:180 Average:4026.00 Median:4383.30 stddev:1155.38 (26.4%) stddev-sans-first:1123.76 07:40:28 INFO - PROCESS | 6193 | Values: 273.1 293.8 294.9 301.7 303.2 4514.5 4627.4 4705.9 4751.9 4757.1 4652.4 4652.8 4677.7 4696.9 4730.3 3770.2 3777.9 3780.6 3780.7 3790.3 3548.3 3595.8 3773.4 3790.8 3795.4 3705.8 3713.0 3722.7 3724.7 3729.6 3720.3 3722.5 3724.7 3727.0 3733.4 3313.5 3313.9 3317.4 3318.4 3323.8 4419.6 4587.9 4588.9 4605.5 4627.4 4218.6 4244.7 4249.6 4255.2 4259.3 4800.6 4916.7 4923.7 4923.7 4931.5 3515.2 3524.7 3528.8 3532.7 3534.5 5141.6 5176.3 5177.8 5184.3 5193.4 3609.1 3611.0 3617.7 3622.2 3629.5 3446.4 3650.9 3664.2 3677.9 3697.1 4183.5 4185.8 4188.5 4191.9 4191.9 4993.6 5002.3 5034.1 5057.2 5058.7 1199.9 1234.3 1268.6 1276.9 1288.5 841.8 864.1 866.6 867.3 875.8 4327.7 4336.2 4355.7 4365.6 4376.8 5054.9 5061.5 5074.3 5078.8 5079.1 4351.3 4372.9 4382.7 4383.9 4384.8 2311.3 2404.9 2408.7 2430.3 2434.2 4191.7 4240.3 4246.7 4273.3 4297.7 4558.2 4570.9 4608.6 4608.7 4614.9 4126.0 4171.6 4267.0 4269.4 4307.6 4504.2 4508.7 4525.7 4537.4 4548.3 4414.1 4425.7 4447.0 4460.5 4473.2 4251.9 4253.4 4293.9 4483.5 4858.0 3641.1 3654.0 3656.8 3670.3 3674.7 5092.7 5103.9 5113.3 5131.6 5133.9 4746.0 4819.8 4918.4 4951.7 4955.2 4955.8 4967.8 4975.6 4975.9 4979.2 4908.6 4919.9 4921.4 4924.6 4932.8 4747.2 4985.9 4995.7 4996.3 5003.3 4881.5 4888.4 4889.8 4919.7 4925.6 07:40:28 INFO - PROCESS | 6193 | 07:40:28 INFO - PROCESS | 6193 | [#5] yui.html Cycles:180 Average:17762.86 Median:44751.83 stddev:25510.43 (57.0%) stddev-sans-first:25549.55 07:40:28 INFO - PROCESS | 6193 | Values: 627.6 676.0 677.4 728.9 731.0 13468.6 14390.4 14504.1 14531.2 14578.6 13349.3 13526.2 13532.1 13532.1 13543.8 614.1 725.9 737.7 758.5 758.8 757.4 767.4 767.8 767.8 768.2 803.1 804.7 804.7 805.2 805.4 637.2 765.5 795.2 797.0 797.5 578.7 581.2 586.2 586.3 586.5 12471.0 12545.9 12630.9 12643.9 12687.6 11880.5 12193.2 12746.2 12872.2 13119.9 11638.2 11816.6 11860.7 12034.8 12476.1 3818.8 3897.7 3921.9 3929.5 4000.7 66345.0 66396.3 66449.0 66563.0 67195.0 9958.7 10072.2 10430.5 10492.0 10499.7 17530.1 17669.2 17712.3 17754.6 18211.8 6583.5 6592.1 6612.7 6687.9 6807.1 3522.8 3562.4 3584.1 3618.7 3690.0 2675.1 2788.1 2789.3 2789.8 2790.4 476.2 481.7 481.9 484.4 532.1 580.5 616.5 618.2 620.8 620.9 8410.6 8427.8 8733.5 8900.2 9070.4 554.3 571.6 616.2 632.5 636.8 4153.5 4187.8 4228.0 4254.2 4320.5 100448.0 100925.0 101655.5 104639.0 105234.0 51621.4 87805.6 88379.4 89216.6 89753.0 45674.1 60516.1 65540.3 71278.0 73106.6 7784.0 7859.5 7932.3 7974.3 8103.6 44619.6 44630.3 44873.3 45602.8 46570.5 57272.4 66060.0 67534.7 67561.0 69772.7 9873.5 9997.9 10000.1 10085.9 10278.8 10883.4 10942.9 11125.4 11513.6 11848.8 9997.9 11923.9 11967.4 11976.5 12895.9 11208.8 11589.0 12081.4 12321.1 12382.5 11817.3 12002.5 12044.5 12286.2 13271.4 9838.8 9885.1 10387.4 10581.6 10593.7 10064.9 10385.8 10581.7 10679.4 10731.1 07:40:28 INFO - PROCESS | 6193 | -------- Summary: end -------- 07:40:28 INFO - PROCESS | 6193 | 07:40:29 INFO - TEST-INFO | 6193: exit 0 07:40:29 INFO - TEST-OK | dromaeo_css | took 1121378ms 07:40:29 INFO - TEST-START | kraken 07:40:29 INFO - operating with platform_type : linux_ 07:40:29 INFO - Initialising browser for kraken test... 07:40:29 INFO - TEST-INFO | started process 6505 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjKdo02/profile http://localhost:56814/getInfo.html) 07:40:34 INFO - PROCESS | 6505 | __metrics Screen width/height:1600/1200 07:40:34 INFO - PROCESS | 6505 | colorDepth:24 07:40:34 INFO - PROCESS | 6505 | Browser inner width/height: 1024/697 07:40:34 INFO - PROCESS | 6505 | __metrics 07:40:34 INFO - PROCESS | 6505 | 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" 07:40:34 INFO - PROCESS | 6505 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:40:35 INFO - PROCESS | 6505 | console.error: PushService: 07:40:35 INFO - PROCESS | 6505 | stateChangeProcessEnqueue: Error transitioning state 07:40:35 INFO - PROCESS | 6505 | UnknownError 07:40:36 INFO - TEST-INFO | 6505: exit 0 07:40:36 INFO - Browser initialized. 07:40:36 INFO - Running cycle 1/1 for kraken test... 07:40:36 INFO - TEST-INFO | started process 6585 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjKdo02/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:40:48 INFO - PROCESS | 6585 | RSS: Main: 179720192 07:40:48 INFO - PROCESS | 6585 | 07:40:51 INFO - PROCESS | 6585 | Cycle 1(1): loaded http://localhost:56814/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56814/tests/kraken/driver.html?testName=audio-beat-detection) 07:40:52 INFO - PROCESS | 6585 | RSS: Main: 233197568 07:40:52 INFO - PROCESS | 6585 | 07:40:55 INFO - PROCESS | 6585 | Cycle 1(1): loaded http://localhost:56814/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56814/tests/kraken/driver.html?testName=audio-dft) 07:40:55 INFO - PROCESS | 6585 | RSS: Main: 224018432 07:40:55 INFO - PROCESS | 6585 | 07:40:58 INFO - PROCESS | 6585 | Cycle 1(1): loaded http://localhost:56814/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56814/tests/kraken/driver.html?testName=audio-fft) 07:40:59 INFO - PROCESS | 6585 | RSS: Main: 304029696 07:40:59 INFO - PROCESS | 6585 | 07:41:01 INFO - PROCESS | 6585 | Cycle 1(1): loaded http://localhost:56814/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56814/tests/kraken/driver.html?testName=audio-oscillator) 07:41:02 INFO - PROCESS | 6585 | RSS: Main: 213262336 07:41:02 INFO - PROCESS | 6585 | 07:41:04 INFO - PROCESS | 6585 | Cycle 1(1): loaded http://localhost:56814/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56814/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:41:05 INFO - PROCESS | 6585 | RSS: Main: 214585344 07:41:05 INFO - PROCESS | 6585 | 07:41:08 INFO - PROCESS | 6585 | Cycle 1(1): loaded http://localhost:56814/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56814/tests/kraken/driver.html?testName=imaging-darkroom) 07:41:08 INFO - PROCESS | 6585 | RSS: Main: 254296064 07:41:08 INFO - PROCESS | 6585 | 07:41:12 INFO - PROCESS | 6585 | Cycle 1(1): loaded http://localhost:56814/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56814/tests/kraken/driver.html?testName=imaging-desaturate) 07:41:13 INFO - PROCESS | 6585 | RSS: Main: 248553472 07:41:13 INFO - PROCESS | 6585 | 07:41:15 INFO - PROCESS | 6585 | Cycle 1(1): loaded http://localhost:56814/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56814/tests/kraken/driver.html?testName=json-parse-financial) 07:41:16 INFO - PROCESS | 6585 | RSS: Main: 250793984 07:41:16 INFO - PROCESS | 6585 | 07:41:18 INFO - PROCESS | 6585 | Cycle 1(1): loaded http://localhost:56814/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56814/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:41:18 INFO - PROCESS | 6585 | RSS: Main: 215359488 07:41:18 INFO - PROCESS | 6585 | 07:41:20 INFO - PROCESS | 6585 | Cycle 1(1): loaded http://localhost:56814/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56814/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:41:21 INFO - PROCESS | 6585 | RSS: Main: 222482432 07:41:21 INFO - PROCESS | 6585 | 07:41:23 INFO - PROCESS | 6585 | Cycle 1(1): loaded http://localhost:56814/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56814/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:41:24 INFO - PROCESS | 6585 | RSS: Main: 220913664 07:41:24 INFO - PROCESS | 6585 | 07:41:27 INFO - PROCESS | 6585 | Cycle 1(1): loaded http://localhost:56814/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56814/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:41:27 INFO - PROCESS | 6585 | RSS: Main: 222507008 07:41:27 INFO - PROCESS | 6585 | 07:41:30 INFO - PROCESS | 6585 | Cycle 1(1): loaded http://localhost:56814/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56814/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:41:31 INFO - PROCESS | 6585 | RSS: Main: 219725824 07:41:31 INFO - PROCESS | 6585 | 07:41:33 INFO - PROCESS | 6585 | Cycle 1(1): loaded http://localhost:56814/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56814/tests/kraken/driver.html?testName=ai-astar) 07:41:33 INFO - PROCESS | 6585 | RSS: Main: 270340096 07:41:33 INFO - PROCESS | 6585 | 07:41:33 INFO - PROCESS | 6585 | __start_tp_report 07:41:33 INFO - PROCESS | 6585 | _x_x_mozilla_page_load 07:41:33 INFO - PROCESS | 6585 | _x_x_mozilla_page_load_details 07:41:33 INFO - PROCESS | 6585 | |i|pagename|runs| 07:41:33 INFO - PROCESS | 6585 | |0;ai-astar;113;115;129;114;113;116;114;114;113;114 07:41:33 INFO - PROCESS | 6585 | |1;audio-beat-detection;158;122;153;184;123;148;169;127;196;126 07:41:33 INFO - PROCESS | 6585 | |2;audio-dft;163;162;161;161;162;163;164;163;162;163 07:41:33 INFO - PROCESS | 6585 | |3;audio-fft;76;77;76;169;77;78;77;77;161;78 07:41:33 INFO - PROCESS | 6585 | |4;audio-oscillator;87;88;157;87;86;88;133;85;86;142 07:41:33 INFO - PROCESS | 6585 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;116;117;117 07:41:33 INFO - PROCESS | 6585 | |6;imaging-darkroom;149;149;150;150;149;149;150;150;149;147 07:41:33 INFO - PROCESS | 6585 | |7;imaging-desaturate;95;96;96;95;94;95;95;95;95;94 07:41:33 INFO - PROCESS | 6585 | |8;json-parse-financial;67;68;66;66;66;67;67;67;65;66 07:41:33 INFO - PROCESS | 6585 | |9;json-stringify-tinderbox;66;67;66;66;66;65;66;66;66;65 07:41:33 INFO - PROCESS | 6585 | |10;stanford-crypto-aes;83;82;82;82;88;82;82;83;83;91 07:41:33 INFO - PROCESS | 6585 | |11;stanford-crypto-ccm;138;136;136;134;155;136;143;132;174;144 07:41:33 INFO - PROCESS | 6585 | |12;stanford-crypto-pbkdf2;169;168;167;171;170;171;171;169;169;169 07:41:33 INFO - PROCESS | 6585 | |13;stanford-crypto-sha256-iterative;69;67;67;68;68;68;69;68;68;67 07:41:33 INFO - PROCESS | 6585 | __end_tp_report 07:41:33 INFO - PROCESS | 6585 | __start_cc_report 07:41:33 INFO - PROCESS | 6585 | _x_x_mozilla_cycle_collect,2000 07:41:33 INFO - PROCESS | 6585 | __end_cc_report 07:41:33 INFO - PROCESS | 6585 | __startTimestamp1472136093412__endTimestamp 07:41:33 INFO - PROCESS | 6585 | 07:41:33 INFO - PROCESS | 6585 | ------- Summary: start ------- 07:41:33 INFO - PROCESS | 6585 | Number of tests: 14 07:41:33 INFO - PROCESS | 6585 | 07:41:33 INFO - PROCESS | 6585 | [#0] ai-astar Cycles:10 Average:115.50 Median:114.00 stddev:4.84 (4.2%) stddev-sans-first:5.04 07:41:33 INFO - PROCESS | 6585 | Values: 113.0 115.0 129.0 114.0 113.0 116.0 114.0 114.0 113.0 114.0 07:41:33 INFO - PROCESS | 6585 | 07:41:33 INFO - PROCESS | 6585 | [#1] audio-beat-detection Cycles:10 Average:150.60 Median:155.50 stddev:26.51 (17.0%) stddev-sans-first:27.98 07:41:33 INFO - PROCESS | 6585 | Values: 158.0 122.0 153.0 184.0 123.0 148.0 169.0 127.0 196.0 126.0 07:41:33 INFO - PROCESS | 6585 | 07:41:33 INFO - PROCESS | 6585 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 07:41:33 INFO - PROCESS | 6585 | Values: 163.0 162.0 161.0 161.0 162.0 163.0 164.0 163.0 162.0 163.0 07:41:33 INFO - PROCESS | 6585 | 07:41:33 INFO - PROCESS | 6585 | [#3] audio-fft Cycles:10 Average:94.60 Median:77.00 stddev:37.16 (48.3%) stddev-sans-first:38.80 07:41:33 INFO - PROCESS | 6585 | Values: 76.0 77.0 76.0 169.0 77.0 78.0 77.0 77.0 161.0 78.0 07:41:33 INFO - PROCESS | 6585 | 07:41:33 INFO - PROCESS | 6585 | [#4] audio-oscillator Cycles:10 Average:103.90 Median:86.50 stddev:28.27 (32.7%) stddev-sans-first:29.32 07:41:33 INFO - PROCESS | 6585 | Values: 87.0 88.0 157.0 87.0 86.0 88.0 133.0 85.0 86.0 142.0 07:41:33 INFO - PROCESS | 6585 | 07:41:33 INFO - PROCESS | 6585 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 07:41:33 INFO - PROCESS | 6585 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 07:41:33 INFO - PROCESS | 6585 | 07:41:33 INFO - PROCESS | 6585 | [#6] imaging-darkroom Cycles:10 Average:149.20 Median:149.50 stddev:0.92 (0.6%) stddev-sans-first:0.97 07:41:33 INFO - PROCESS | 6585 | Values: 149.0 149.0 150.0 150.0 149.0 149.0 150.0 150.0 149.0 147.0 07:41:33 INFO - PROCESS | 6585 | 07:41:33 INFO - PROCESS | 6585 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 07:41:33 INFO - PROCESS | 6585 | Values: 95.0 96.0 96.0 95.0 94.0 95.0 95.0 95.0 95.0 94.0 07:41:33 INFO - PROCESS | 6585 | 07:41:33 INFO - PROCESS | 6585 | [#8] json-parse-financial Cycles:10 Average:66.50 Median:67.00 stddev:0.85 (1.3%) stddev-sans-first:0.88 07:41:33 INFO - PROCESS | 6585 | Values: 67.0 68.0 66.0 66.0 66.0 67.0 67.0 67.0 65.0 66.0 07:41:33 INFO - PROCESS | 6585 | 07:41:33 INFO - PROCESS | 6585 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 07:41:33 INFO - PROCESS | 6585 | Values: 66.0 67.0 66.0 66.0 66.0 65.0 66.0 66.0 66.0 65.0 07:41:33 INFO - PROCESS | 6585 | 07:41:33 INFO - PROCESS | 6585 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:83.00 stddev:3.12 (3.8%) stddev-sans-first:3.30 07:41:33 INFO - PROCESS | 6585 | Values: 83.0 82.0 82.0 82.0 88.0 82.0 82.0 83.0 83.0 91.0 07:41:33 INFO - PROCESS | 6585 | 07:41:33 INFO - PROCESS | 6585 | [#11] stanford-crypto-ccm Cycles:10 Average:142.80 Median:140.50 stddev:12.82 (9.1%) stddev-sans-first:13.48 07:41:33 INFO - PROCESS | 6585 | Values: 138.0 136.0 136.0 134.0 155.0 136.0 143.0 132.0 174.0 144.0 07:41:33 INFO - PROCESS | 6585 | 07:41:33 INFO - PROCESS | 6585 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.40 Median:169.50 stddev:1.35 (0.8%) stddev-sans-first:1.42 07:41:33 INFO - PROCESS | 6585 | Values: 169.0 168.0 167.0 171.0 170.0 171.0 171.0 169.0 169.0 169.0 07:41:33 INFO - PROCESS | 6585 | 07:41:33 INFO - PROCESS | 6585 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:0.74 (1.1%) stddev-sans-first:0.67 07:41:33 INFO - PROCESS | 6585 | Values: 69.0 67.0 67.0 68.0 68.0 68.0 69.0 68.0 68.0 67.0 07:41:33 INFO - PROCESS | 6585 | -------- Summary: end -------- 07:41:33 INFO - PROCESS | 6585 | 07:41:34 INFO - TEST-INFO | 6585: exit 0 07:41:34 INFO - TEST-OK | kraken | took 64895ms 07:41:34 INFO - SUITE-END | took 1186s 07:41:35 INFO - Completed test suite (00:19:46) 07:41:35 INFO - javascript benchmark 07:41:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2555.552778263804, 2560.1807421625062, 2576.0339872547793, 2578.9871050644742, 2597.7791887689546, 4517.796699148538, 4579.465151725093, 4608.5161058088925, 4643.466001409839, 4723.90552188956, 4579.4046773919345, 4588.105319462706, 4604.516525764797, 4639.489656137822, 4710.199266124759, 4231.322988321869, 4243.681723870706, 4251.532331443539, 4251.787410629471, 4375.08123294107, 4285.164392943378, 4322.265214913472, 4355.6515478761785, 4370.6503479721705, 4373.081652852905, 4154.709170358076, 4288.421063156465, 4332.7400355978425, 4336.609705126538, 4358.825646974117, 4186.6859985500905, 4216.704830661855, 4251.59609837065, 4257.382679511485, 4270.039241170743, 4223.0709243966585, 4231.217224813388, 4287.678424118204, 4292.720973136736, 4296.9140617187795, 4665.231922722156, 4687.601553867891, 4690.413698287714, 4690.882727931795, 4726.692764970266, 4786.856394308142, 4958.9008219835405, 5011.649184557083, 5014.5737612303, 5030.5221004004925, 5042.974785126087, 5050.141475949097, 5055.388518744191, 5061.291419201315, 5081.187010078406, 4505.887352816206, 4723.504032076583, 4731.929021064687, 4732.810687572527, 4733.763311834464, 5030.396352437658, 5054.09026375256, 5057.190849464068, 5066.594672426197, 5143.922841157386, 4855.5387238212315, 4862.562369386772, 4867.586255168279, 4868.342773725572, 4919.262110683355, 4835.057163853015, 4957.058158949788, 4967.05625931072, 4968.801247950041, 5022.673526220784, 4806.591439727592, 4834.564889159992, 4839.830605928775, 4895.6083513318845, 4912.0, 4834.057358815067, 4840.540148685869, 4841.3222148899185, 4852.927206091911, 4899.461059283476, 4199.811008504625, 4202.222588821078, 4205.0959043805115, 4208.116295577902, 4249.277622804131, 3643.690286325639, 3658.9634103659155, 3701.833417496165, 3707.295613833363, 3735.1782607826235, 4344.044310251739, 4344.500382455994, 4393.956060439355, 4402.053558484877, 4404.031113155101, 5039.874003149951, 5043.218301163325, 5047.116754567936, 5052.8484145475695, 5118.923216151761, 4185.686073544496, 4247.256730072225, 4257.340112282539, 4340.934885976713, 4347.652187824967, 4469.262571675637, 4489.214387482178, 4531.161735079021, 4532.093581283756, 4552.408186935743, 4667.696599721007, 4669.883252918568, 4670.696404733681, 4672.95327046732, 4730.006698593334, 4779.880502987453, 4960.925586116284, 4966.701997880139, 4974.0, 5019.573336266459, 4721.693089949143, 4743.644226683082, 4745.881352966204, 4779.283107533898, 4797.832075877328, 4934.654574179916, 4940.851774446773, 4941.555260026615, 4943.65394422387, 5000.874978125576, 4862.610991120631, 4917.5328343808715, 4925.38432695913, 5016.172331565251, 5070.847874563769, 4787.210110331756, 4814.422269327703, 4814.446338670958, 4834.854954351375, 4902.509749025069, 4831.154547954024, 4833.10587541306, 4834.250691142878, 4835.274708793709, 4900.191468407673, 4685.8594242172785, 4777.355057067391, 4785.066911952275, 4789.808407663654, 4848.006158737521, 4831.806727730851, 4868.075065737498, 4883.682560633548, 4900.068986892479, 4962.032403681247, 4774.594159496482, 4777.546133117348, 4780.2829575562555, 4786.976065119652, 4837.298591704253], "value": 4568.431930692895, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.2973124132352, 566.9766072239609, 570.5977286013361, 572.2617823008319, 572.997135014325, 28342.14973550794, 38681.419778703304, 40335.596644033554, 40430.19139617209, 43549.12901741963, 39403.605963940354, 39766.0, 39900.401493977544, 39917.0, 39974.40038399426, 7575.393968482522, 7721.22787721229, 7728.961355193216, 7730.111037230734, 7731.149573546905, 7647.885281720779, 7736.226377362275, 7742.032245969254, 7742.690292388298, 7745.419093568005, 7709.1134519530415, 7732.342750866183, 7754.340881025119, 7758.0, 7760.0, 7711.498752581064, 7747.109082455477, 7749.845003099963, 7751.147373788879, 7756.922430775733, 7633.427492938052, 7663.27198916102, 7682.692692292301, 7694.846103077963, 7695.961520192419, 37596.43605345922, 37835.24329513394, 37863.81068094642, 37957.620423795684, 38089.0, 2978.9851050744605, 3132.1699749566383, 3194.073718621597, 3400.4559270516847, 3418.8632454701783, 28562.143135705963, 28904.71095289041, 29049.273768155756, 29183.0, 29285.853570732223, 3163.4938409854544, 3225.6774322567558, 3265.853036613358, 3368.2758206985613, 3378.341223461426, 242039.0, 242380.0, 243142.0, 243290.0, 243784.0, 31113.0, 50659.746701266995, 51143.488565113876, 51241.48758512367, 51273.0, 31528.527072093937, 33332.16669583231, 33337.833310833776, 33354.49968250478, 33369.165770855434, 12965.416556254992, 13091.541796037283, 13092.214467132002, 13093.607191784262, 13098.083134180515, 9898.554565044591, 9974.950125249326, 10063.798724025479, 10077.949610251902, 10084.949575252223, 7663.348615367645, 7748.380129589619, 7802.414818888606, 7806.765797026098, 7811.336036436966, 3006.774491913115, 3047.2686555226587, 3068.2022674104446, 3085.691430856896, 3095.907122786275, 831.9542425166553, 866.9436486628349, 875.3216257400566, 876.6712482818942, 886.2909672262165, 27412.862935685192, 28303.71696283052, 28376.71623283782, 29078.854605726836, 29094.563581546292, 932.7854593443546, 952.0717300631828, 967.7241986033946, 977.6529332087149, 1014.523174108168, 14154.36305366261, 14871.256437178097, 15188.316525756367, 15289.694206115815, 15415.997960132556, 376888.0, 381287.0, 381352.0, 381952.0, 383846.0, 47897.281540776916, 48727.269090963666, 48859.755701221264, 48901.0, 48912.75543622259, 1035.35807799165, 1132.6941725734005, 1190.8570971483305, 1192.3680449361852, 1194.8924596786158, 26861.462770744867, 27909.860450697615, 28069.0, 28982.855085724437, 30254.0, 45764.771176143906, 46438.0, 46461.0, 46504.7674761624, 46516.30225546687, 338827.0, 342458.0, 342914.0, 343359.0, 344181.0, 30145.397092058476, 38268.234635307694, 38514.229715404974, 40207.396889047275, 40936.59063409447, 40916.590834092465, 41433.0, 41679.1664166721, 41766.79116604398, 42376.78811605922, 35470.290594187456, 35474.290514190085, 35591.64408355987, 35781.64218357887, 36404.81797590995, 35177.64822351846, 35759.0, 35822.0, 35923.82038089793, 36296.0, 34104.829475852464, 34337.828310858284, 34758.0, 34780.82609586936, 35012.47481287834, 30364.84817575898, 32881.506777398834, 33025.33949321048, 33036.50445243371, 33085.33829323352, 24736.752632473446, 25031.49937001286, 25272.241832745047, 25554.488910222062, 25694.87152564225], "value": 16471.265342435898, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.8761877152383, 373.49764566657853, 374.92688925659496, 382.89087610031146, 397.3265315290582, 15989.120598367084, 17216.225269862854, 17837.894328242335, 17923.46229613112, 18093.1858066387, 15933.01766491041, 17250.39623613174, 17396.39112631058, 17425.390111346107, 17514.82485175148, 4868.196747536661, 5124.231365295198, 5129.666571672848, 5132.101882170605, 5135.075686376451, 5068.974655126719, 5124.333836601255, 5149.227615857632, 5349.063913815066, 5369.785208591652, 5456.61803673743, 5509.696966666832, 5520.91718624221, 5522.530584900288, 5526.364468086162, 5267.947320526784, 5350.438203988583, 5371.274877891474, 5376.489233522809, 5529.3364796224505, 5164.793408263665, 5174.741262936838, 5190.558802501791, 5197.870053248661, 5204.687718736888, 14251.0, 14511.70976580473, 20845.270415535382, 20896.791032089637, 20974.700186461738, 1840.8494690818238, 1917.4151883675474, 1932.4106147624968, 1934.6614342490009, 1976.160131943918, 9282.0, 9424.387414818015, 9448.149666530046, 9897.505124743806, 9937.0, 1712.8715346349074, 1750.3873644224548, 1764.3560100563202, 1791.167107295114, 1795.1383335998664, 62453.0, 69495.65252173757, 69836.30163698399, 71221.64389178072, 71803.0, 10022.498875056219, 10284.691459256233, 10340.431276279727, 10439.791204175874, 10466.162706983423, 13657.590272291847, 13664.521741738992, 14053.718925621635, 14073.296335183404, 14104.294785260696, 5929.703514824241, 5992.250968628921, 6487.935120648827, 7249.746258880914, 7452.441066919894, 6856.897146542806, 6890.31096890307, 7077.681504332318, 7087.964560177269, 7168.211496735355, 3964.2467931093, 4318.827246910088, 7799.45403821727, 8322.583870806435, 8334.458260213189, 2978.8510574471625, 2998.3165067265113, 3101.9689803102133, 3367.74741894354, 3439.3121375724454, 756.3306473770753, 821.5029906906356, 831.7338451695521, 890.7327801659605, 903.9819203615891, 17042.23309951055, 17050.74423883643, 17885.28458861631, 18283.360082397317, 18594.628107437777, 765.2309429023907, 826.2522417212432, 848.5672307123289, 872.7905302727427, 882.8278485695228, 9276.582553785096, 9920.553575089138, 9985.900140998498, 9997.800043999225, 10026.949865250626, 141427.0, 141551.29224354017, 141672.29163854115, 142174.0, 144361.27819360836, 59546.40453595495, 70493.647531762, 72106.0, 81584.59207704042, 82732.0, 902.309733054214, 908.2098574240453, 948.4451595816387, 950.0736781637986, 950.5294879034922, 15784.684306314039, 16161.838381616033, 16327.346906123623, 17076.23156957915, 17162.141892905056, 37635.24729505449, 38199.0, 38254.40947086368, 38464.230715384976, 39035.21929561449, 51980.480195199074, 52276.73861630668, 53119.0, 53448.465515344345, 53931.73034134804, 6784.0, 7014.929850701427, 7094.503384763224, 7263.237360077116, 7415.962920185365, 9595.712128636153, 11748.118891083373, 11919.642410727693, 12133.939330303292, 12522.937385313015, 10065.849012264676, 10222.897771022492, 10253.179745620184, 10646.148308135485, 10823.618803863137, 10274.434906080238, 10647.0, 10721.839172412265, 10759.75074548495, 10873.565057397933, 9788.0, 9844.2124630028, 10170.745731356776, 10771.13830893511, 10830.0, 7062.3996960258955, 7213.963930180315, 7285.672144753605, 7353.411727061715, 7478.925210748041, 9877.259205559756, 9962.402255864672, 10011.349262297927, 10111.39331640104, 10609.734756631146], "value": 8180.801776717113, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1373.457484293704, 1388.5140200929675, 1437.2741765408466, 1607.4936395035563, 1631.2822358162416, 6588.53880228383, 7129.180144283409, 7267.454940879429, 7765.49524280922, 7772.4170687198475, 7430.256974302567, 7637.312641862231, 7661.578613176273, 7675.194104619019, 7692.0, 2161.5892980333724, 2188.627933251343, 2191.123550579765, 2192.5943700415396, 2194.5501172259646, 1816.8455681267042, 2080.9687854682193, 2126.234555560005, 2155.6012137754487, 2171.413718296059, 2137.326742076241, 2155.374941267031, 2169.6853956176346, 2169.8806565638884, 2169.913203471859, 2121.8090371866606, 2124.1821898569083, 2145.184829764695, 2149.118861266889, 2153.192552792703, 2134.7971942665577, 2145.2706079932896, 2154.7737487563736, 2160.25471212433, 2171.16410182081, 7899.249571290718, 7961.36309095271, 7966.880496792553, 7980.760577182694, 7981.880271795928, 4478.462584489849, 4651.279051746951, 4655.092257009885, 4666.066786642651, 4667.043256132519, 2870.626818513601, 2926.88292468301, 2998.9550156747664, 3000.3999200160056, 3037.726604605574, 906.3610154840821, 937.3017102258792, 957.1672644798999, 960.9375390599658, 970.9805803883953, 9653.855192172123, 9901.603935842557, 10076.798464030679, 10510.894891051068, 10520.210984176141, 4103.528094269138, 4228.344606585984, 4288.31386978082, 4357.912841743211, 4381.671374646914, 8258.0, 8259.091499935003, 8259.174082591813, 8264.0, 8269.46248493846, 4582.977085114553, 4616.261398176276, 4629.282461218517, 4660.04469083837, 4667.463241727245, 4168.478940132483, 4240.088380998101, 4256.127493863751, 4259.297215959394, 4262.893427664271, 3247.2693643930397, 3355.5973283205685, 3378.797272163678, 3405.216800135983, 3428.9485657715154, 904.3127223310331, 1008.349614498659, 1018.1956254558963, 1062.054771253585, 1066.1630619963291, 836.1178956201145, 837.8676268895675, 843.1442086282428, 851.8159757936473, 876.5923845411914, 5201.479852014768, 5308.814191503356, 5425.647332923348, 5427.375851777097, 5474.890502189934, 858.2576071698061, 861.9742506417343, 878.9956050219708, 888.0852721696534, 911.2345629671108, 3577.0878426001204, 3607.404778211618, 3656.2504686539196, 3670.834812433447, 3805.9429108563395, 9548.42709437436, 9658.951705241428, 9809.166220871162, 9950.452725100044, 9966.352187107816, 9825.213982881352, 9825.4104753715, 9831.950840245752, 9831.950840245896, 9835.704928852147, 7388.556686598821, 7421.888671669929, 7455.440841936768, 7457.216992215847, 7505.699772009168, 5271.736413179249, 5307.601929855199, 5344.946550534601, 5410.431904650112, 5486.972565137149, 8964.238039766433, 9054.27565794748, 9055.18503334703, 9176.128267814547, 9181.311401645036, 8851.46891186531, 8890.555472226491, 8947.418417802823, 8988.146126118008, 9075.319351048565, 6889.793306200822, 6967.8606427870145, 6994.405475534637, 7010.193827709879, 7067.858642827217, 7585.279398457138, 7610.238976102345, 7647.235276472308, 7648.273414025659, 7649.694012239448, 6773.119494465688, 6827.863442731018, 6878.037074809631, 6890.44876409876, 7001.264867188872, 6770.763023294161, 6798.490113241428, 6820.965895170492, 6860.176778786577, 6866.793996180123, 6393.136926515047, 6413.935860641521, 6436.0, 6456.418922297016, 6533.640649764308, 4534.478534968389, 4592.196365636067, 4669.136209801198, 4823.252395878644, 4825.10735513931, 4644.2801365788355, 4732.716037037789, 4846.80612775485, 4867.1969125093965, 4933.038057578738], "value": 4133.340466345546, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [273.1069403052019, 293.8002158532197, 294.90120809528804, 301.7269371219047, 303.17385125532917, 4514.525974772642, 4627.421572303462, 4705.905881882364, 4751.8574442766685, 4757.0723708876785, 4652.371929789478, 4652.7906244219, 4677.719336839792, 4696.906061878761, 4730.337752714614, 3770.2271034438013, 3777.8666400080006, 3780.640839120279, 3780.6786423153926, 3790.2987947229713, 3548.2903419316112, 3595.7842529448185, 3773.3585290500682, 3790.8294126764363, 3795.392737162055, 3705.8147092645395, 3713.0, 3722.702183825301, 3724.7020238381, 3729.5710993235716, 3720.330340538702, 3722.5346831645907, 3724.7392682512236, 3726.962730372689, 3733.4399840023943, 3313.453280208763, 3313.8625586496573, 3317.4360358739073, 3318.3574130805164, 3323.7839540430036, 4419.558044195587, 4587.8666420114805, 4588.862334129982, 4605.516420775803, 4627.444706635191, 4218.578142185757, 4244.745315281062, 4249.618873866006, 4255.1915136124035, 4259.339802330613, 4800.591949684281, 4916.729579873106, 4923.655344125913, 4923.679960802572, 4931.457539670633, 3515.2442224921765, 3524.718022558189, 3528.7882727036204, 3532.717382609385, 3534.505169276303, 5141.640085194038, 5176.301199338079, 5177.792888284502, 5184.326037615086, 5193.350831146145, 3609.097725568608, 3610.9638903611153, 3617.7286703497343, 3622.185008373095, 3629.4737263096704, 3446.4141096013736, 3650.945235821465, 3664.157243833933, 3677.9264414711556, 3697.149655579178, 4183.45615070045, 4185.790710464465, 4188.476440444944, 4191.8742437726305, 4191.874243772691, 4993.625478089158, 5002.324686167321, 5034.11902916988, 5057.190849464068, 5058.721770302669, 1199.9020895880346, 1234.3211233821542, 1268.5877089945805, 1276.8850803427736, 1288.5168061976758, 841.8442588121217, 864.1444969480295, 866.5883705239961, 867.3494878840869, 875.8335916175906, 4327.7186982846015, 4336.197803406317, 4355.716878402957, 4365.607095361433, 4376.803043863034, 5054.898902022012, 5061.544460998528, 5074.264231686385, 5078.847634570969, 5079.060373830853, 4351.26028575143, 4372.934405983913, 4382.737035777864, 4383.868483945486, 4384.802683879233, 2311.306608017622, 2404.891779869875, 2408.6989126359204, 2430.258771074804, 2434.2210492642184, 4191.664666826647, 4240.279152544075, 4246.72396294246, 4273.316269396943, 4297.699161058696, 4558.247889098328, 4570.88572785683, 4608.584912727531, 4608.700434471749, 4614.946348874719, 4125.958740412618, 4171.561985991488, 4266.954596123969, 4269.40228368035, 4307.569243075667, 4504.166729155117, 4508.684392092522, 4525.683202175947, 4537.364768932418, 4548.317752337043, 4414.139242847614, 4425.672298310558, 4447.0, 4460.483435631901, 4473.217186992329, 4251.917359914038, 4253.383259427427, 4293.935590966201, 4483.506814250495, 4857.95142048575, 3641.1443310821405, 3653.963460365362, 3656.762310449812, 3670.3209906167444, 3674.669279764834, 5092.7199004053655, 5103.928175083274, 5113.346854362512, 5131.615128865425, 5133.897322053613, 4746.0, 4819.807207711652, 4918.360613120271, 4951.72765497901, 4955.182394904945, 4955.82654607087, 4967.82612608557, 4975.601951843916, 4975.880426903917, 4979.203327467588, 4908.558229759339, 4919.926201107058, 4921.434035086011, 4924.630652701134, 4932.778024988956, 4747.240441529339, 4985.903101317705, 4995.650304478651, 4996.2505624156665, 5003.324551185543, 4881.536254055859, 4888.364512613338, 4889.828855990023, 4919.704817710949, 4925.605951523941], "value": 3662.484008879888, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [627.5732501898709, 675.9763408280708, 677.355146017568, 728.9325563356472, 730.9890351644726, 13468.595942121727, 14390.424383024692, 14504.129752214862, 14531.200783956878, 14578.635534111652, 13349.332533373317, 13526.18842869426, 13532.052756307063, 13532.120412173203, 13543.796843047363, 614.0788816774838, 725.9491835571512, 737.7307282841764, 758.5069704691939, 758.7647829172946, 757.3978686943865, 767.3860911270989, 767.7965339185121, 767.8042099264708, 768.1511929318107, 803.1125606205147, 804.7263930263709, 804.7344376355818, 805.2149154574302, 805.4160733468218, 637.1621317966859, 765.5291995422775, 795.2445177081795, 796.9721059762938, 797.5254723439544, 578.6788332475475, 581.2327727399834, 586.214472606709, 586.2730214533947, 586.5278450847067, 12471.002319814394, 12545.93727031359, 12630.873691263061, 12643.873561264361, 12687.555935542305, 11880.524779008829, 12193.207441516362, 12746.171498852545, 12872.22766634005, 13119.86880131196, 11638.185327027111, 11816.586419475363, 11860.703482413008, 12034.759304813855, 12476.064295177806, 3818.7517811342173, 3897.6881849451975, 3921.9215615687526, 3929.5413209756753, 4000.659943904772, 66345.0, 66396.33603663999, 66449.0, 66563.0, 67195.0, 9958.651447199458, 10072.194224462171, 10430.530626121843, 10492.0, 10499.68500944973, 17530.12349382551, 17669.20488578017, 17712.291508339524, 17754.556136096442, 18211.817881821276, 6583.539152259296, 6592.077109204715, 6612.669366531654, 6687.899681504781, 6807.0810440589885, 3522.84147213376, 3562.447820587813, 3584.068142282973, 3618.6743193112748, 3689.963100368962, 2675.1172113202597, 2788.093869492423, 2789.316617428743, 2789.7768178545666, 2790.4279622677304, 476.15720175289545, 481.70134516599234, 481.86507777822266, 484.3509697006029, 532.1219987021445, 580.5210701171466, 616.5252755378334, 618.2179542878263, 620.8106527509153, 620.8634100497883, 8410.579471026547, 8427.789305267417, 8733.51965641883, 8900.198982091513, 9070.365074444857, 554.276668947028, 571.5856004396862, 616.1527899138684, 632.5445679111033, 636.7803107927757, 4153.54311025787, 4187.811548480326, 4227.957720422818, 4254.212970600449, 4320.481542214891, 100448.0, 100925.0, 101655.4917225424, 104639.0, 105234.0, 51621.426974942115, 87805.56097219473, 88379.4173961302, 89216.5539172313, 89753.0, 45674.08651826945, 60516.092258616154, 65540.34459655438, 71278.0, 73106.63446682839, 7784.0, 7859.52842829432, 7932.286094251545, 7974.282314591715, 8103.594820258845, 44619.55380446284, 44630.3305450412, 44873.326900095875, 45602.77198614118, 46570.534294656616, 57272.427275728376, 66060.00909986258, 67534.66232668805, 67561.0, 69772.651136744, 9873.50632468388, 9997.900020999698, 10000.149987251165, 10085.899141008496, 10278.794424111626, 10883.401412922365, 10942.890571094187, 11125.388103654377, 11513.597024104116, 11848.763024739284, 9997.850032249376, 11923.940380298043, 11967.401629918644, 11976.520939162336, 12895.871041289467, 11208.831867522156, 11589.0, 12081.395930203278, 12321.075919306268, 12382.504699812267, 11817.290962542274, 12002.459889304828, 12044.457999390224, 12286.201396909173, 13271.402786874422, 9838.803223935623, 9885.110340069428, 10387.37675739458, 10581.576736930436, 10593.735156621146, 10064.949675251577, 10385.792284154124, 10581.682549523526, 10679.359238445719, 10731.141508679131], "value": 6571.568802134124, "unit": "score"}], "name": "dromaeo_css", "value": 6278.378993024296, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 129.0, 114.0, 113.0, 116.0, 114.0, 114.0, 113.0, 114.0], "value": 115.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 122.0, 153.0, 184.0, 123.0, 148.0, 169.0, 127.0, 196.0, 126.0], "value": 150.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 161.0, 161.0, 162.0, 163.0, 164.0, 163.0, 162.0, 163.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 169.0, 77.0, 78.0, 77.0, 77.0, 161.0, 78.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 157.0, 87.0, 86.0, 88.0, 133.0, 85.0, 86.0, 142.0], "value": 103.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 150.0, 150.0, 149.0, 149.0, 150.0, 150.0, 149.0, 147.0], "value": 149.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 66.0, 66.0, 66.0, 67.0, 67.0, 67.0, 65.0, 66.0], "value": 66.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 66.0, 66.0, 65.0, 66.0, 66.0, 66.0, 65.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 82.0, 82.0, 88.0, 82.0, 82.0, 83.0, 83.0, 91.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 136.0, 136.0, 134.0, 155.0, 136.0, 143.0, 132.0, 174.0, 144.0], "value": 142.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 168.0, 167.0, 171.0, 170.0, 171.0, 171.0, 169.0, 169.0, 169.0], "value": 169.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 67.0, 68.0, 68.0, 68.0, 69.0, 68.0, 68.0, 67.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1584.4, "alertThreshold": 2.0}]} 07:41:35 INFO - Return code: 0 07:41:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:41:35 INFO - # TBPL SUCCESS # 07:41:35 INFO - Running post-action listener: _resource_record_post_action 07:41:35 INFO - [mozharness: 2016-08-25 14:41:35.221152Z] Finished run-tests step (success) 07:41:35 INFO - Running post-run listener: _resource_record_post_run 07:41:35 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 417792; Write bytes: 416800768; Read time: 28; Write time: 256568 07:41:35 INFO - TinderboxPrint: CPU usage
13.0% 07:41:35 INFO - TinderboxPrint: I/O read bytes / time
417,792 / 28 07:41:35 INFO - TinderboxPrint: I/O write bytes / time
416,800,768 / 256,568 07:41:35 INFO - TinderboxPrint: CPU idle
8,345.6 (86.9%) 07:41:35 INFO - TinderboxPrint: CPU user
1,204.2 (12.5%) 07:41:35 INFO - TinderboxPrint: Swap in / out
0 / 0 07:41:35 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 114270208; Read time: 0; Write time: 67088 07:41:35 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 417792; Write bytes: 291233792; Read time: 28; Write time: 185808 07:41:35 INFO - Running post-run listener: _upload_blobber_files 07:41:35 INFO - Blob upload gear active. 07:41:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:41:35 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 07:41:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:41:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:41:36 INFO - (blobuploader) - INFO - Open directory for files ... 07:41:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:41:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:41:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:41:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:41:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:41:37 INFO - (blobuploader) - INFO - Done attempting. 07:41:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:41:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:41:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:41:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:41:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:41:38 INFO - (blobuploader) - INFO - Done attempting. 07:41:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:41:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:41:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:41:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:41:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:41:41 INFO - (blobuploader) - INFO - Done attempting. 07:41:41 INFO - (blobuploader) - INFO - Iteration through files over. 07:41:41 INFO - Return code: 0 07:41:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:41:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:41:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2be7d5242cfa1b02e6b1408325d18aa6d9cd398f607201729416452a5b12afb92b3376e21093f4ee6664fd75f90f000d5609fecd4a204e6845489f9f894594b0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3c7c52665c804ac8e41c467e74dee73fbd66c4b56d278b0bb9f1fa93424e9f8bb5d4475f40c3ee56c92a8fa7e0da74587ac4e5f21b90e986381237759074bff7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/71fa9c1724e29b9c64dda7c905ff5edfb57691cc28de8a5e24c8c9857eaf8895d16a31bf3c8527946dd575aa2b1f2ea1b7bdbcfb55a057b1a534f86ad6fa0a82"} 07:41:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:41:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:41:41 INFO - Contents: 07:41:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2be7d5242cfa1b02e6b1408325d18aa6d9cd398f607201729416452a5b12afb92b3376e21093f4ee6664fd75f90f000d5609fecd4a204e6845489f9f894594b0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3c7c52665c804ac8e41c467e74dee73fbd66c4b56d278b0bb9f1fa93424e9f8bb5d4475f40c3ee56c92a8fa7e0da74587ac4e5f21b90e986381237759074bff7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/71fa9c1724e29b9c64dda7c905ff5edfb57691cc28de8a5e24c8c9857eaf8895d16a31bf3c8527946dd575aa2b1f2ea1b7bdbcfb55a057b1a534f86ad6fa0a82"} 07:41:41 INFO - Running post-run listener: copy_logs_to_upload_dir 07:41:41 INFO - Copying logs to upload dir... 07:41:41 INFO - mkdir: /builds/slave/test/build/upload/logs 07:41:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.868782 ========= master_lag: 84.46 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 14 secs) (at 2016-08-25 07:43:06.364373) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-25 07:43:06.368086) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1472134252.930079-1383729287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2be7d5242cfa1b02e6b1408325d18aa6d9cd398f607201729416452a5b12afb92b3376e21093f4ee6664fd75f90f000d5609fecd4a204e6845489f9f894594b0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3c7c52665c804ac8e41c467e74dee73fbd66c4b56d278b0bb9f1fa93424e9f8bb5d4475f40c3ee56c92a8fa7e0da74587ac4e5f21b90e986381237759074bff7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/71fa9c1724e29b9c64dda7c905ff5edfb57691cc28de8a5e24c8c9857eaf8895d16a31bf3c8527946dd575aa2b1f2ea1b7bdbcfb55a057b1a534f86ad6fa0a82"} build_url:https://queue.taskcluster.net/v1/task/DrZF3wgaT3aReiDHmNm8Ow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011494 build_url: 'https://queue.taskcluster.net/v1/task/DrZF3wgaT3aReiDHmNm8Ow/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-Non-PGO/sha512/2be7d5242cfa1b02e6b1408325d18aa6d9cd398f607201729416452a5b12afb92b3376e21093f4ee6664fd75f90f000d5609fecd4a204e6845489f9f894594b0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3c7c52665c804ac8e41c467e74dee73fbd66c4b56d278b0bb9f1fa93424e9f8bb5d4475f40c3ee56c92a8fa7e0da74587ac4e5f21b90e986381237759074bff7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/71fa9c1724e29b9c64dda7c905ff5edfb57691cc28de8a5e24c8c9857eaf8895d16a31bf3c8527946dd575aa2b1f2ea1b7bdbcfb55a057b1a534f86ad6fa0a82"}' ========= master_lag: 0.19 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-25 07:43:06.567407) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 07:43:06.567690) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1472134252.930079-1383729287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004386 ========= master_lag: 0.13 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 07:43:06.697268) ========= ========= Started reboot skipped (results: 3, elapsed: 2 secs) (at 2016-08-25 07:43:06.697546) ========= ========= Finished reboot skipped (results: 3, elapsed: 2 secs) (at 2016-08-25 07:43:09.229853) ========= ========= Total master_lag: 84.83 =========