builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-013 starttime: 1471971219.83 results: success (0) buildid: 20160823080458 builduid: a2b4d81c2c674d329bffc448498cd257 revision: 8381bc7a46811aa0de0d984cdb6f1cc5ce4c52c2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-23 09:53:39.825611) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-23 09:53:39.826052) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-23 09:53:39.826322) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-23 09:53:39.848552) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 09:53:39.848898) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1471971216.845022-1881525037 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-23 09:53:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 110M=0s 2016-08-23 09:53:40 (110 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.130239 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 09:53:39.993171) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 09:53:39.993493) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1471971216.845022-1881525037 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020410 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 09:53:40.043411) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-23 09:53:40.044268) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8381bc7a46811aa0de0d984cdb6f1cc5ce4c52c2 --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 8381bc7a46811aa0de0d984cdb6f1cc5ce4c52c2 --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=9c3a94c35cc88655b05d2c08000001b2-1471971216.845022-1881525037 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-23 09:53:40,195 truncating revision to first 12 chars 2016-08-23 09:53:40,195 Setting DEBUG logging. 2016-08-23 09:53:40,195 attempt 1/10 2016-08-23 09:53:40,195 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8381bc7a4681?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-23 09:53:41,471 unpacking tar archive at: fx-team-8381bc7a4681/testing/mozharness/ program finished with exit code 0 elapsedTime=1.615272 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-23 09:53:41.673262) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-23 09:53:41.673563) ========= script_repo_revision: 8381bc7a46811aa0de0d984cdb6f1cc5ce4c52c2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-23 09:53:41.673966) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-23 09:53:41.674225) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-23 09:53:41.682388) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-08-23 09:53:41.682658) ========= /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=9c3a94c35cc88655b05d2c08000001b2-1471971216.845022-1881525037 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:53:41 INFO - MultiFileLogger online at 20160823 09:53:41 in /builds/slave/test 09:53:41 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 09:53:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:53:41 INFO - {'append_to_log': False, 09:53:41 INFO - 'base_work_dir': '/builds/slave/test', 09:53:41 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:53:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:53:41 INFO - 'branch': 'Fx-Team-Non-PGO', 09:53:41 INFO - 'buildbot_json_path': 'buildprops.json', 09:53:41 INFO - 'config_files': ('talos/linux_config.py',), 09:53:41 INFO - 'default_actions': ('clobber', 09:53:41 INFO - 'read-buildbot-config', 09:53:41 INFO - 'download-and-extract', 09:53:41 INFO - 'populate-webroot', 09:53:41 INFO - 'create-virtualenv', 09:53:41 INFO - 'install', 09:53:41 INFO - 'run-tests'), 09:53:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:53:41 INFO - 'download_minidump_stackwalk': True, 09:53:41 INFO - 'download_symbols': 'ondemand', 09:53:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:53:41 INFO - 'tooltool.py': '/tools/tooltool.py', 09:53:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:53:41 INFO - '/tools/misc-python/virtualenv.py')}, 09:53:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:53:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:53:41 INFO - 'installer_path': 'installer.exe', 09:53:41 INFO - 'log_level': 'info', 09:53:41 INFO - 'log_name': 'talos', 09:53:41 INFO - 'log_to_console': True, 09:53:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:53:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:53:41 INFO - 'opt_config_files': (), 09:53:41 INFO - 'pip_index': False, 09:53:41 INFO - 'sps_profile': False, 09:53:41 INFO - 'sps_profile_interval': 0, 09:53:41 INFO - 'suite': 'dromaeojs', 09:53:41 INFO - 'system_bits': '32', 09:53:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:53:41 INFO - 'title': 'talos-linux64-ix-013', 09:53:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:53:41 INFO - 'use_talos_json': True, 09:53:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:53:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:53:41 INFO - 'work_dir': 'build'} 09:53:41 INFO - [mozharness: 2016-08-23 16:53:41.926004Z] Running clobber step. 09:53:41 INFO - Running pre-action listener: _resource_record_pre_action 09:53:41 INFO - Running main action method: clobber 09:53:41 INFO - rmtree: /builds/slave/test/build 09:53:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:53:42 INFO - Running post-action listener: _resource_record_post_action 09:53:42 INFO - [mozharness: 2016-08-23 16:53:42.379084Z] Finished clobber step (success) 09:53:42 INFO - [mozharness: 2016-08-23 16:53:42.379185Z] Running read-buildbot-config step. 09:53:42 INFO - Running pre-action listener: _resource_record_pre_action 09:53:42 INFO - Running main action method: read_buildbot_config 09:53:42 INFO - Using buildbot properties: 09:53:42 INFO - { 09:53:42 INFO - "project": "", 09:53:42 INFO - "product": "firefox", 09:53:42 INFO - "script_repo_revision": "production", 09:53:42 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:53:42 INFO - "repository": "", 09:53:42 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 09:53:42 INFO - "buildid": "20160823080458", 09:53:42 INFO - "pgo_build": "False", 09:53:42 INFO - "basedir": "/builds/slave/test", 09:53:42 INFO - "buildnumber": 3256, 09:53:42 INFO - "slavename": "talos-linux64-ix-013", 09:53:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:53:42 INFO - "platform": "ubuntu64_hw", 09:53:42 INFO - "scheduler": "tests-fx-team-linux64-talos-7-3600", 09:53:42 INFO - "branch": "fx-team", 09:53:42 INFO - "repo_path": "integration/fx-team", 09:53:42 INFO - "revision": "8381bc7a46811aa0de0d984cdb6f1cc5ce4c52c2", 09:53:42 INFO - "stage_platform": "linux64", 09:53:42 INFO - "builduid": "a2b4d81c2c674d329bffc448498cd257", 09:53:42 INFO - "slavebuilddir": "test" 09:53:42 INFO - } 09:53:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/TtWoa8L8TjOWiu-gs17hsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 09:53:42 INFO - Running post-action listener: _resource_record_post_action 09:53:42 INFO - [mozharness: 2016-08-23 16:53:42.381641Z] Finished read-buildbot-config step (success) 09:53:42 INFO - [mozharness: 2016-08-23 16:53:42.381730Z] Running download-and-extract step. 09:53:42 INFO - Running pre-action listener: _resource_record_pre_action 09:53:42 INFO - Running main action method: download_and_extract 09:53:42 INFO - mkdir: /builds/slave/test/build/tests 09:53:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:53:42 INFO - trying https://queue.taskcluster.net/v1/task/TtWoa8L8TjOWiu-gs17hsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 09:53:42 INFO - Downloading https://queue.taskcluster.net/v1/task/TtWoa8L8TjOWiu-gs17hsg/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 09:53:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TtWoa8L8TjOWiu-gs17hsg/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 09:53:42 INFO - Downloaded 1361 bytes. 09:53:42 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 09:53:42 INFO - Using the following test package requirements: 09:53:42 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 09:53:42 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:53:42 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:53:42 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:53:42 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:53:42 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:53:42 INFO - u'jsshell-linux-x86_64.zip'], 09:53:42 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:53:42 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:53:42 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 09:53:42 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:53:42 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:53:42 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:53:42 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:53:42 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:53:42 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:53:42 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:53:42 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:53:42 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:53:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:53:42 INFO - trying https://queue.taskcluster.net/v1/task/TtWoa8L8TjOWiu-gs17hsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 09:53:42 INFO - Downloading https://queue.taskcluster.net/v1/task/TtWoa8L8TjOWiu-gs17hsg/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 09:53:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TtWoa8L8TjOWiu-gs17hsg/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 09:53:43 INFO - Downloaded 20324645 bytes. 09:53:43 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 09:53:48 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 09:53: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')]} 09:53:48 INFO - trying https://queue.taskcluster.net/v1/task/TtWoa8L8TjOWiu-gs17hsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 09:53:48 INFO - Downloading https://queue.taskcluster.net/v1/task/TtWoa8L8TjOWiu-gs17hsg/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 09:53:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TtWoa8L8TjOWiu-gs17hsg/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 09:53:48 INFO - Downloaded 20324645 bytes. 09:53:48 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 09:53: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')]} 09:53:53 INFO - trying https://queue.taskcluster.net/v1/task/TtWoa8L8TjOWiu-gs17hsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 09:53:53 INFO - Downloading https://queue.taskcluster.net/v1/task/TtWoa8L8TjOWiu-gs17hsg/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 09:53:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TtWoa8L8TjOWiu-gs17hsg/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 09:53:54 INFO - Downloaded 14413981 bytes. 09:53:54 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 09:53:54 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')]} 09:53:54 INFO - trying https://queue.taskcluster.net/v1/task/TtWoa8L8TjOWiu-gs17hsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:53:54 INFO - Downloading https://queue.taskcluster.net/v1/task/TtWoa8L8TjOWiu-gs17hsg/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 09:53:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TtWoa8L8TjOWiu-gs17hsg/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 09:53:55 INFO - Downloaded 55740682 bytes. 09:53:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TtWoa8L8TjOWiu-gs17hsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:53:55 INFO - mkdir: /builds/slave/test/properties 09:53:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:53:55 INFO - Writing to file /builds/slave/test/properties/build_url 09:53:55 INFO - Contents: 09:53:55 INFO - build_url:https://queue.taskcluster.net/v1/task/TtWoa8L8TjOWiu-gs17hsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:53:56 INFO - Running post-action listener: _resource_record_post_action 09:53:56 INFO - Running post-action listener: set_extra_try_arguments 09:53:56 INFO - [mozharness: 2016-08-23 16:53:56.503394Z] Finished download-and-extract step (success) 09:53:56 INFO - [mozharness: 2016-08-23 16:53:56.503619Z] Running populate-webroot step. 09:53:56 INFO - Running pre-action listener: _resource_record_pre_action 09:53:56 INFO - Running main action method: populate_webroot 09:53:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:53:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:53:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:53:56 INFO - '--tppagecycles', 09:53:56 INFO - '7'], 09:53:56 INFO - 'tests': ['tsvgm']}}, 09:53:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:53:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:53:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:53:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:53:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:53:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:53:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:53:56 INFO - 'talos_options': ['--disable-e10s'], 09:53:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:53:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:53:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:53:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:53:56 INFO - 'talos_options': ['--disable-e10s'], 09:53:56 INFO - 'tests': ['damp', 'tps']}, 09:53:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:53:56 INFO - 'tests': ['damp', 'tps']}, 09:53:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:53:56 INFO - 'tests': ['dromaeo_dom']}, 09:53:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:53:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:53:56 INFO - 'tests': ['basic_compositor_video']}, 09:53:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:53:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:53:56 INFO - 'tests': ['a11yr', 09:53:56 INFO - 'ts_paint', 09:53:56 INFO - 'tpaint', 09:53:56 INFO - 'sessionrestore', 09:53:56 INFO - 'sessionrestore_no_auto_restore', 09:53:56 INFO - 'tabpaint']}, 09:53:56 INFO - 'other-e10s': {'tests': ['a11yr', 09:53:56 INFO - 'ts_paint', 09:53:56 INFO - 'tpaint', 09:53:56 INFO - 'sessionrestore', 09:53:56 INFO - 'sessionrestore_no_auto_restore', 09:53:56 INFO - 'tabpaint']}, 09:53:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:53:56 INFO - 'ts_paint', 09:53:56 INFO - 'tpaint', 09:53:56 INFO - 'sessionrestore', 09:53:56 INFO - 'sessionrestore_no_auto_restore', 09:53:56 INFO - 'tabpaint']}, 09:53:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:53:56 INFO - 'ts_paint', 09:53:56 INFO - 'tpaint', 09:53:56 INFO - 'sessionrestore', 09:53:56 INFO - 'sessionrestore_no_auto_restore', 09:53:56 INFO - 'tabpaint']}, 09:53:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:53:56 INFO - 'tests': ['a11yr', 09:53:56 INFO - 'ts_paint', 09:53:56 INFO - 'tpaint', 09:53:56 INFO - 'sessionrestore', 09:53:56 INFO - 'sessionrestore_no_auto_restore', 09:53:56 INFO - 'tabpaint']}, 09:53:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:53:56 INFO - 'tests': ['a11yr', 09:53:56 INFO - 'ts_paint', 09:53:56 INFO - 'tpaint', 09:53:56 INFO - 'sessionrestore', 09:53:56 INFO - 'sessionrestore_no_auto_restore', 09:53:56 INFO - 'tabpaint']}, 09:53:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:53:56 INFO - 'tests': ['tsvgx', 09:53:56 INFO - 'tsvgr_opacity', 09:53:56 INFO - 'tart', 09:53:56 INFO - 'tscrollx', 09:53:56 INFO - 'cart']}, 09:53:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:53:56 INFO - 'tsvgr_opacity', 09:53:56 INFO - 'tart', 09:53:56 INFO - 'tscrollx', 09:53:56 INFO - 'cart']}, 09:53:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:53:56 INFO - 'talos_options': ['--disable-e10s'], 09:53:56 INFO - 'tests': ['tp5o']}, 09:53:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:53:56 INFO - 'tests': ['tp5o']}, 09:53:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:53:56 INFO - 'talos_options': ['--disable-e10s', 09:53:56 INFO - '--xperf_path', 09:53:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:53:56 INFO - 'tests': ['tp5n']}, 09:53:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:53:56 INFO - 'talos_options': ['--xperf_path', 09:53:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:53:56 INFO - 'tests': ['tp5n']}}, 09:53:56 INFO - 'talos.zip': {'path': '', 09:53:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:53:56 INFO - Running post-action listener: _resource_record_post_action 09:53:56 INFO - [mozharness: 2016-08-23 16:53:56.524762Z] Finished populate-webroot step (success) 09:53:56 INFO - [mozharness: 2016-08-23 16:53:56.524849Z] Running create-virtualenv step. 09:53:56 INFO - Running pre-action listener: _resource_record_pre_action 09:53:56 INFO - Running main action method: create_virtualenv 09:53:56 INFO - Creating virtualenv /builds/slave/test/build/venv 09:53:56 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 09:53:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:53:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:53:56 INFO - Using real prefix '/usr' 09:53:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:53:57 INFO - Installing distribute.............................................................................................................................................................................................done. 09:53:59 INFO - Installing pip.................done. 09:53:59 INFO - Return code: 0 09:53:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:53: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')]} 09:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53: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')]} 09:53:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:59 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 0x7f538ee79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f1230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16eb090>, '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 0x16ee9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16eee40>, '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': '9c3a94c35cc88655b05d2c08000001b2-1471971216.845022-1881525037', '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 09:53:59 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 09:53:59 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 09:53:59 INFO - Using env: {'DISPLAY': ':0', 09:53:59 INFO - 'HOME': '/home/cltbld', 09:53:59 INFO - 'LANG': 'en_US.UTF-8', 09:53:59 INFO - 'LANGUAGE': 'en_US:en', 09:53:59 INFO - 'LOGNAME': 'cltbld', 09:53:59 INFO - 'MAIL': '/var/mail/cltbld', 09:53:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:59 INFO - 'MOZ_NO_REMOTE': '1', 09:53:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:53:59 INFO - 'NO_EM_RESTART': '1', 09:53:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:53:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:59 INFO - 'PWD': '/builds/slave/test', 09:53:59 INFO - 'SHELL': '/bin/bash', 09:53:59 INFO - 'SHLVL': '1', 09:53:59 INFO - 'TERM': 'linux', 09:53:59 INFO - 'TMOUT': '86400', 09:53:59 INFO - 'USER': 'cltbld', 09:53:59 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1471971216.845022-1881525037', 09:53:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:59 INFO - '_': '/tools/buildbot/bin/python'} 09:53:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:59 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 09:53:59 INFO - Cleaning up... 09:53:59 INFO - Return code: 0 09:53:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:53: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')]} 09:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53: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')]} 09:53:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:59 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 0x7f538ee79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f1230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16eb090>, '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 0x16ee9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16eee40>, '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': '9c3a94c35cc88655b05d2c08000001b2-1471971216.845022-1881525037', '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 09:53:59 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 09:53:59 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 09:53:59 INFO - Using env: {'DISPLAY': ':0', 09:53:59 INFO - 'HOME': '/home/cltbld', 09:53:59 INFO - 'LANG': 'en_US.UTF-8', 09:53:59 INFO - 'LANGUAGE': 'en_US:en', 09:53:59 INFO - 'LOGNAME': 'cltbld', 09:53:59 INFO - 'MAIL': '/var/mail/cltbld', 09:53:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:59 INFO - 'MOZ_NO_REMOTE': '1', 09:53:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:53:59 INFO - 'NO_EM_RESTART': '1', 09:53:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:53:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:59 INFO - 'PWD': '/builds/slave/test', 09:53:59 INFO - 'SHELL': '/bin/bash', 09:53:59 INFO - 'SHLVL': '1', 09:53:59 INFO - 'TERM': 'linux', 09:53:59 INFO - 'TMOUT': '86400', 09:53:59 INFO - 'USER': 'cltbld', 09:53:59 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1471971216.845022-1881525037', 09:53:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:59 INFO - '_': '/tools/buildbot/bin/python'} 09:53:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:59 INFO - Downloading/unpacking psutil>=3.1.1 09:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:54:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:54:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:54:01 INFO - Installing collected packages: psutil 09:54:01 INFO - Running setup.py install for psutil 09:54:01 INFO - building 'psutil._psutil_linux' extension 09:54:01 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 09:54:01 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 09:54:01 INFO - building 'psutil._psutil_posix' extension 09:54:01 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 09:54:01 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 09:54:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:54:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:54:02 INFO - Successfully installed psutil 09:54:02 INFO - Cleaning up... 09:54:02 INFO - Return code: 0 09:54:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:54:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:54:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:54:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:02 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 0x7f538ee79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f1230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16eb090>, '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 0x16ee9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16eee40>, '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': '9c3a94c35cc88655b05d2c08000001b2-1471971216.845022-1881525037', '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 09:54:02 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 09:54:02 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 09:54:02 INFO - Using env: {'DISPLAY': ':0', 09:54:02 INFO - 'HOME': '/home/cltbld', 09:54:02 INFO - 'LANG': 'en_US.UTF-8', 09:54:02 INFO - 'LANGUAGE': 'en_US:en', 09:54:02 INFO - 'LOGNAME': 'cltbld', 09:54:02 INFO - 'MAIL': '/var/mail/cltbld', 09:54:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:02 INFO - 'MOZ_NO_REMOTE': '1', 09:54:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:54:02 INFO - 'NO_EM_RESTART': '1', 09:54:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:54:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:02 INFO - 'PWD': '/builds/slave/test', 09:54:02 INFO - 'SHELL': '/bin/bash', 09:54:02 INFO - 'SHLVL': '1', 09:54:02 INFO - 'TERM': 'linux', 09:54:02 INFO - 'TMOUT': '86400', 09:54:02 INFO - 'USER': 'cltbld', 09:54:02 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1471971216.845022-1881525037', 09:54:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:02 INFO - '_': '/tools/buildbot/bin/python'} 09:54:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:54:02 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 09:54:02 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 09:54:02 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 09:54:02 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 09:54:02 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 09:54:02 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 09:54:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:54:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:54:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:54:04 INFO - Installing collected packages: mozsystemmonitor 09:54:04 INFO - Running setup.py install for mozsystemmonitor 09:54:04 INFO - Successfully installed mozsystemmonitor 09:54:04 INFO - Cleaning up... 09:54:04 INFO - Return code: 0 09:54:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:54: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')]} 09:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54: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')]} 09:54:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:04 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 0x7f538ee79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f1230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16eb090>, '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 0x16ee9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16eee40>, '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': '9c3a94c35cc88655b05d2c08000001b2-1471971216.845022-1881525037', '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 09:54:04 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 09:54:04 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 09:54:04 INFO - Using env: {'DISPLAY': ':0', 09:54:04 INFO - 'HOME': '/home/cltbld', 09:54:04 INFO - 'LANG': 'en_US.UTF-8', 09:54:04 INFO - 'LANGUAGE': 'en_US:en', 09:54:04 INFO - 'LOGNAME': 'cltbld', 09:54:04 INFO - 'MAIL': '/var/mail/cltbld', 09:54:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:04 INFO - 'MOZ_NO_REMOTE': '1', 09:54:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:54:04 INFO - 'NO_EM_RESTART': '1', 09:54:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:54:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:04 INFO - 'PWD': '/builds/slave/test', 09:54:04 INFO - 'SHELL': '/bin/bash', 09:54:04 INFO - 'SHLVL': '1', 09:54:04 INFO - 'TERM': 'linux', 09:54:04 INFO - 'TMOUT': '86400', 09:54:04 INFO - 'USER': 'cltbld', 09:54:04 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1471971216.845022-1881525037', 09:54:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:04 INFO - '_': '/tools/buildbot/bin/python'} 09:54:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:04 INFO - Downloading/unpacking jsonschema==2.5.1 09:54:04 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 09:54:04 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 09:54:04 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 09:54:04 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 09:54:04 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 09:54:04 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 09:54:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:54:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:54:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:54:06 INFO - Downloading functools32-3.2.3-2.tar.gz 09:54:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:54:06 INFO - warning: no files found matching '*.txt' 09:54:06 INFO - no previously-included directories found matching 'build' 09:54:06 INFO - no previously-included directories found matching 'dist' 09:54:06 INFO - no previously-included directories found matching '.git*' 09:54:06 INFO - Installing collected packages: jsonschema, functools32 09:54:06 INFO - Running setup.py install for functools32 09:54:06 INFO - warning: no files found matching '*.txt' 09:54:06 INFO - no previously-included directories found matching 'build' 09:54:06 INFO - no previously-included directories found matching 'dist' 09:54:06 INFO - no previously-included directories found matching '.git*' 09:54:06 INFO - Successfully installed jsonschema functools32 09:54:06 INFO - Cleaning up... 09:54:06 INFO - Return code: 0 09:54:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:54: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')]} 09:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54: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')]} 09:54:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:06 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 0x7f538ee79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f1230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16eb090>, '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 0x16ee9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16eee40>, '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': '9c3a94c35cc88655b05d2c08000001b2-1471971216.845022-1881525037', '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 09:54:06 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 09:54:06 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 09:54:06 INFO - Using env: {'DISPLAY': ':0', 09:54:06 INFO - 'HOME': '/home/cltbld', 09:54:06 INFO - 'LANG': 'en_US.UTF-8', 09:54:06 INFO - 'LANGUAGE': 'en_US:en', 09:54:06 INFO - 'LOGNAME': 'cltbld', 09:54:06 INFO - 'MAIL': '/var/mail/cltbld', 09:54:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:06 INFO - 'MOZ_NO_REMOTE': '1', 09:54:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:54:06 INFO - 'NO_EM_RESTART': '1', 09:54:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:54:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:06 INFO - 'PWD': '/builds/slave/test', 09:54:06 INFO - 'SHELL': '/bin/bash', 09:54:06 INFO - 'SHLVL': '1', 09:54:06 INFO - 'TERM': 'linux', 09:54:06 INFO - 'TMOUT': '86400', 09:54:06 INFO - 'USER': 'cltbld', 09:54:06 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1471971216.845022-1881525037', 09:54:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:06 INFO - '_': '/tools/buildbot/bin/python'} 09:54:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:54:07 INFO - Cleaning up... 09:54:07 INFO - Return code: 0 09:54:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:54:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:54:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:07 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 0x7f538ee79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f1230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16eb090>, '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 0x16ee9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16eee40>, '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': '9c3a94c35cc88655b05d2c08000001b2-1471971216.845022-1881525037', '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 09:54:07 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 09:54:07 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 09:54:07 INFO - Using env: {'DISPLAY': ':0', 09:54:07 INFO - 'HOME': '/home/cltbld', 09:54:07 INFO - 'LANG': 'en_US.UTF-8', 09:54:07 INFO - 'LANGUAGE': 'en_US:en', 09:54:07 INFO - 'LOGNAME': 'cltbld', 09:54:07 INFO - 'MAIL': '/var/mail/cltbld', 09:54:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:07 INFO - 'MOZ_NO_REMOTE': '1', 09:54:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:54:07 INFO - 'NO_EM_RESTART': '1', 09:54:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:54:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:07 INFO - 'PWD': '/builds/slave/test', 09:54:07 INFO - 'SHELL': '/bin/bash', 09:54:07 INFO - 'SHLVL': '1', 09:54:07 INFO - 'TERM': 'linux', 09:54:07 INFO - 'TMOUT': '86400', 09:54:07 INFO - 'USER': 'cltbld', 09:54:07 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1471971216.845022-1881525037', 09:54:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:07 INFO - '_': '/tools/buildbot/bin/python'} 09:54:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:07 INFO - Downloading/unpacking blobuploader==1.2.4 09:54:07 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 09:54:07 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 09:54:07 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 09:54:07 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 09:54:07 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 09:54:07 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 09:54:09 INFO - Downloading blobuploader-1.2.4.tar.gz 09:54:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:54:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:54:09 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 09:54:09 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 09:54:09 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 09:54:09 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 09:54:09 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 09:54:09 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 09:54:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:54:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:54:09 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 09:54:09 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 09:54:09 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 09:54:09 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 09:54:09 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 09:54:09 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 09:54:09 INFO - Downloading docopt-0.6.1.tar.gz 09:54:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:54:09 INFO - Installing collected packages: blobuploader, requests, docopt 09:54:09 INFO - Running setup.py install for blobuploader 09:54:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:54:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:54:10 INFO - Running setup.py install for requests 09:54:10 INFO - Running setup.py install for docopt 09:54:10 INFO - Successfully installed blobuploader requests docopt 09:54:10 INFO - Cleaning up... 09:54:10 INFO - Return code: 0 09:54:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:54:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:54:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:54:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:10 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 0x7f538ee79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f1230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16eb090>, '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 0x16ee9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16eee40>, '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': '9c3a94c35cc88655b05d2c08000001b2-1471971216.845022-1881525037', '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 09:54:10 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 09:54:10 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 09:54:10 INFO - Using env: {'DISPLAY': ':0', 09:54:10 INFO - 'HOME': '/home/cltbld', 09:54:10 INFO - 'LANG': 'en_US.UTF-8', 09:54:10 INFO - 'LANGUAGE': 'en_US:en', 09:54:10 INFO - 'LOGNAME': 'cltbld', 09:54:10 INFO - 'MAIL': '/var/mail/cltbld', 09:54:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:10 INFO - 'MOZ_NO_REMOTE': '1', 09:54:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:54:10 INFO - 'NO_EM_RESTART': '1', 09:54:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:54:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:10 INFO - 'PWD': '/builds/slave/test', 09:54:10 INFO - 'SHELL': '/bin/bash', 09:54:10 INFO - 'SHLVL': '1', 09:54:10 INFO - 'TERM': 'linux', 09:54:10 INFO - 'TMOUT': '86400', 09:54:10 INFO - 'USER': 'cltbld', 09:54:10 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1471971216.845022-1881525037', 09:54:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:10 INFO - '_': '/tools/buildbot/bin/python'} 09:54:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:54:10 INFO - Running setup.py (path:/tmp/pip-eBVAfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:54:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:54:10 INFO - Running setup.py (path:/tmp/pip-3brChu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:54:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:54:10 INFO - Running setup.py (path:/tmp/pip-pt0dKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:54:11 INFO - Running setup.py (path:/tmp/pip-O7vqqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:54:11 INFO - Running setup.py (path:/tmp/pip-JrDUFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:54:11 INFO - Running setup.py (path:/tmp/pip-xO0bbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:54:11 INFO - Running setup.py (path:/tmp/pip-N0mCpF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:54:11 INFO - Running setup.py (path:/tmp/pip-PR6yyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:54:11 INFO - Running setup.py (path:/tmp/pip-IyCLDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:54:11 INFO - Running setup.py (path:/tmp/pip-sp54pq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:54:11 INFO - Running setup.py (path:/tmp/pip-gAK9_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:54:11 INFO - Running setup.py (path:/tmp/pip-H8vISC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:54:11 INFO - Running setup.py (path:/tmp/pip-0P1Con-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:54:11 INFO - Running setup.py (path:/tmp/pip-rsY6rv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:54:11 INFO - Running setup.py (path:/tmp/pip-1Mx9eg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:54:11 INFO - Running setup.py (path:/tmp/pip-hEzVLn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:54:11 INFO - Running setup.py (path:/tmp/pip-NXh15b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:54:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:54:12 INFO - Running setup.py install for manifestparser 09:54:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:54:12 INFO - Running setup.py install for mozcrash 09:54:12 INFO - Running setup.py install for mozdebug 09:54:12 INFO - Running setup.py install for mozdevice 09:54:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:54:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:54:12 INFO - Running setup.py install for mozfile 09:54:12 INFO - Running setup.py install for mozhttpd 09:54:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:54:12 INFO - Running setup.py install for mozinfo 09:54:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:54:12 INFO - Running setup.py install for mozInstall 09:54:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:54:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:54:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:54:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:54:12 INFO - Running setup.py install for mozleak 09:54:12 INFO - Running setup.py install for mozlog 09:54:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:54:13 INFO - Running setup.py install for moznetwork 09:54:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:54:13 INFO - Running setup.py install for mozprocess 09:54:13 INFO - Running setup.py install for mozprofile 09:54:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:54:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:54:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:54:13 INFO - Running setup.py install for mozrunner 09:54:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:54:13 INFO - Running setup.py install for mozscreenshot 09:54:13 INFO - Running setup.py install for moztest 09:54:13 INFO - Running setup.py install for mozversion 09:54:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:54:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:54:13 INFO - Cleaning up... 09:54:13 INFO - Return code: 0 09:54:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:54:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:54:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:13 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 0x7f538ee79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f1230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16eb090>, '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 0x16ee9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16eee40>, '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': '9c3a94c35cc88655b05d2c08000001b2-1471971216.845022-1881525037', '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 09:54:13 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 09:54:13 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 09:54:13 INFO - Using env: {'DISPLAY': ':0', 09:54:13 INFO - 'HOME': '/home/cltbld', 09:54:13 INFO - 'LANG': 'en_US.UTF-8', 09:54:13 INFO - 'LANGUAGE': 'en_US:en', 09:54:13 INFO - 'LOGNAME': 'cltbld', 09:54:13 INFO - 'MAIL': '/var/mail/cltbld', 09:54:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:13 INFO - 'MOZ_NO_REMOTE': '1', 09:54:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:54:13 INFO - 'NO_EM_RESTART': '1', 09:54:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:54:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:13 INFO - 'PWD': '/builds/slave/test', 09:54:13 INFO - 'SHELL': '/bin/bash', 09:54:13 INFO - 'SHLVL': '1', 09:54:13 INFO - 'TERM': 'linux', 09:54:13 INFO - 'TMOUT': '86400', 09:54:13 INFO - 'USER': 'cltbld', 09:54:13 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1471971216.845022-1881525037', 09:54:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:13 INFO - '_': '/tools/buildbot/bin/python'} 09:54:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:54:14 INFO - Running setup.py (path:/tmp/pip-SnUcnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:54:14 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)) 09:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:54:14 INFO - Running setup.py (path:/tmp/pip-jzew7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:54:14 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)) 09:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:54:14 INFO - Running setup.py (path:/tmp/pip-qMdTn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:54:14 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)) 09:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:54:14 INFO - Running setup.py (path:/tmp/pip-fXbIkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:54:14 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)) 09:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:54:14 INFO - Running setup.py (path:/tmp/pip-q86Wes-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:54:14 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)) 09:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:54:14 INFO - Running setup.py (path:/tmp/pip-yOpvAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:54:14 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)) 09:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:54:14 INFO - Running setup.py (path:/tmp/pip-vWVkl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:54:14 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)) 09:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:54:14 INFO - Running setup.py (path:/tmp/pip-FOAuRF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:54:14 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)) 09:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:54:14 INFO - Running setup.py (path:/tmp/pip-nK6IWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:54:14 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)) 09:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:54:14 INFO - Running setup.py (path:/tmp/pip-XFw8ag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:54:14 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)) 09:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:54:14 INFO - Running setup.py (path:/tmp/pip-61kxj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:54:14 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)) 09:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:54:14 INFO - Running setup.py (path:/tmp/pip-aaqq3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:54:14 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)) 09:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:54:14 INFO - Running setup.py (path:/tmp/pip-JRF74z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:54:14 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)) 09:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:54:15 INFO - Running setup.py (path:/tmp/pip-q_Mlmq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:54:15 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)) 09:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:54:15 INFO - Running setup.py (path:/tmp/pip-CyARWO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:54:15 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)) 09:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:54:15 INFO - Running setup.py (path:/tmp/pip-c6Nd3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:54:15 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)) 09:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:54:15 INFO - Running setup.py (path:/tmp/pip-S5FMCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:54:15 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)) 09:54:15 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)) 09:54:15 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)) 09:54:15 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)) 09:54:15 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)) 09:54:15 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)) 09:54:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:54: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 09:54: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 09:54: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 09:54: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 09:54: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 09:54: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 09:54:17 INFO - Downloading blessings-1.6.tar.gz 09:54:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:54:17 INFO - Installing collected packages: blessings 09:54:17 INFO - Running setup.py install for blessings 09:54:17 INFO - Successfully installed blessings 09:54:17 INFO - Cleaning up... 09:54:17 INFO - Return code: 0 09:54:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:54:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:54:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:54:17 INFO - Reading from file tmpfile_stdout 09:54:17 INFO - Current package versions: 09:54:17 INFO - argparse == 1.2.1 09:54:17 INFO - blessings == 1.6 09:54:17 INFO - blobuploader == 1.2.4 09:54:17 INFO - docopt == 0.6.1 09:54:17 INFO - functools32 == 3.2.3-2 09:54:17 INFO - jsonschema == 2.5.1 09:54:17 INFO - manifestparser == 1.1 09:54:17 INFO - mozInstall == 1.12 09:54:17 INFO - mozcrash == 0.17 09:54:17 INFO - mozdebug == 0.1 09:54:17 INFO - mozdevice == 0.48 09:54:17 INFO - mozfile == 1.2 09:54:17 INFO - mozhttpd == 0.7 09:54:17 INFO - mozinfo == 0.9 09:54:17 INFO - mozleak == 0.1 09:54:17 INFO - mozlog == 3.3 09:54:17 INFO - moznetwork == 0.27 09:54:17 INFO - mozprocess == 0.23 09:54:17 INFO - mozprofile == 0.28 09:54:17 INFO - mozrunner == 6.12 09:54:17 INFO - mozscreenshot == 0.1 09:54:17 INFO - mozsystemmonitor == 0.3 09:54:17 INFO - moztest == 0.7 09:54:17 INFO - mozversion == 1.4 09:54:17 INFO - psutil == 3.1.1 09:54:17 INFO - requests == 1.2.3 09:54:17 INFO - wsgiref == 0.1.2 09:54:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:54: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')]} 09:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54: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')]} 09:54:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54:17 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 0x7f538ee79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f1230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16eb090>, '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 0x16ee9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16eee40>, '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': '9c3a94c35cc88655b05d2c08000001b2-1471971216.845022-1881525037', '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 09:54:17 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 09:54:17 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 09:54:17 INFO - Using env: {'DISPLAY': ':0', 09:54:17 INFO - 'HOME': '/home/cltbld', 09:54:17 INFO - 'LANG': 'en_US.UTF-8', 09:54:17 INFO - 'LANGUAGE': 'en_US:en', 09:54:17 INFO - 'LOGNAME': 'cltbld', 09:54:17 INFO - 'MAIL': '/var/mail/cltbld', 09:54:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:17 INFO - 'MOZ_NO_REMOTE': '1', 09:54:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:54:17 INFO - 'NO_EM_RESTART': '1', 09:54:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:54:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:17 INFO - 'PWD': '/builds/slave/test', 09:54:17 INFO - 'SHELL': '/bin/bash', 09:54:17 INFO - 'SHLVL': '1', 09:54:17 INFO - 'TERM': 'linux', 09:54:17 INFO - 'TMOUT': '86400', 09:54:17 INFO - 'USER': 'cltbld', 09:54:17 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1471971216.845022-1881525037', 09:54:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:17 INFO - '_': '/tools/buildbot/bin/python'} 09:54:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:17 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)) 09:54:17 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)) 09:54:17 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)) 09:54:17 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)) 09:54:17 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)) 09:54:17 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)) 09:54:17 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)) 09:54:17 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)) 09:54:17 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)) 09:54:17 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)) 09:54:17 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)) 09:54:17 INFO - Cleaning up... 09:54:17 INFO - Return code: 0 09:54:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:54: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')]} 09:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:54:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54: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')]} 09:54:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:54:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:54: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f538ee79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f1230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16eb090>, '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 0x16ee9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16eee40>, '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': '9c3a94c35cc88655b05d2c08000001b2-1471971216.845022-1881525037', '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 09:54: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'] in /builds/slave/test/build 09:54: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 09:54:17 INFO - Using env: {'DISPLAY': ':0', 09:54:17 INFO - 'HOME': '/home/cltbld', 09:54:17 INFO - 'LANG': 'en_US.UTF-8', 09:54:17 INFO - 'LANGUAGE': 'en_US:en', 09:54:17 INFO - 'LOGNAME': 'cltbld', 09:54:17 INFO - 'MAIL': '/var/mail/cltbld', 09:54:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:17 INFO - 'MOZ_NO_REMOTE': '1', 09:54:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:54:17 INFO - 'NO_EM_RESTART': '1', 09:54:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:54:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:17 INFO - 'PWD': '/builds/slave/test', 09:54:17 INFO - 'SHELL': '/bin/bash', 09:54:17 INFO - 'SHLVL': '1', 09:54:17 INFO - 'TERM': 'linux', 09:54:17 INFO - 'TMOUT': '86400', 09:54:17 INFO - 'USER': 'cltbld', 09:54:17 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1471971216.845022-1881525037', 09:54:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:17 INFO - '_': '/tools/buildbot/bin/python'} 09:54:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:54:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:54:18 INFO - Cleaning up... 09:54:18 INFO - Return code: 0 09:54:18 INFO - Running post-action listener: _resource_record_post_action 09:54:18 INFO - Running post-action listener: _start_resource_monitoring 09:54:18 INFO - Starting resource monitoring. 09:54:18 INFO - [mozharness: 2016-08-23 16:54:18.098856Z] Finished create-virtualenv step (success) 09:54:18 INFO - [mozharness: 2016-08-23 16:54:18.099326Z] Running install step. 09:54:18 INFO - Running pre-action listener: _resource_record_pre_action 09:54:18 INFO - Running main action method: install 09:54:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:54:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:54:18 INFO - Reading from file tmpfile_stdout 09:54:18 INFO - Detecting whether we're running mozinstall >=1.0... 09:54:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:54:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:54:18 INFO - Reading from file tmpfile_stdout 09:54:18 INFO - Output received: 09:54:18 INFO - Usage: mozinstall [options] installer 09:54:18 INFO - Options: 09:54:18 INFO - -h, --help show this help message and exit 09:54:18 INFO - -d DEST, --destination=DEST 09:54:18 INFO - Directory to install application into. [default: 09:54:18 INFO - "/builds/slave/test"] 09:54:18 INFO - --app=APP Application being installed. [default: firefox] 09:54:18 INFO - mkdir: /builds/slave/test/build/application 09:54:18 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'] 09:54:18 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 09:54:34 INFO - Reading from file tmpfile_stdout 09:54:34 INFO - Output received: 09:54:34 INFO - /builds/slave/test/build/application/firefox/firefox 09:54:34 INFO - Running post-action listener: _resource_record_post_action 09:54:34 INFO - [mozharness: 2016-08-23 16:54:34.481166Z] Finished install step (success) 09:54:34 INFO - [mozharness: 2016-08-23 16:54:34.481413Z] Running run-tests step. 09:54:34 INFO - Running pre-action listener: _resource_record_pre_action 09:54:34 INFO - Running main action method: run_tests 09:54:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:54:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:54:34 INFO - Python 2.7.3 09:54:34 INFO - Return code: 0 09:54:34 INFO - grabbing minidump binary from tooltool 09:54:34 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')]} 09:54:34 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 0x16eb090>, '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 0x16ee9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16eee40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:54:34 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 09:54:34 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 09:54:34 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 09:54:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:54:34 INFO - Return code: 0 09:54:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:54:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:54:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:54:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:54:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:54:34 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/TtWoa8L8TjOWiu-gs17hsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 09:54:34 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/TtWoa8L8TjOWiu-gs17hsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 09:54:34 INFO - Using env: {'DISPLAY': ':0', 09:54:34 INFO - 'HOME': '/home/cltbld', 09:54:34 INFO - 'LANG': 'en_US.UTF-8', 09:54:34 INFO - 'LANGUAGE': 'en_US:en', 09:54:34 INFO - 'LOGNAME': 'cltbld', 09:54:34 INFO - 'MAIL': '/var/mail/cltbld', 09:54:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:54:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:54:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:54:34 INFO - 'MOZ_NO_REMOTE': '1', 09:54:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:54:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:54:34 INFO - 'NO_EM_RESTART': '1', 09:54:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:54:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:54:34 INFO - 'PWD': '/builds/slave/test', 09:54:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:54:34 INFO - 'SHELL': '/bin/bash', 09:54:34 INFO - 'SHLVL': '1', 09:54:34 INFO - 'TERM': 'linux', 09:54:34 INFO - 'TMOUT': '86400', 09:54:34 INFO - 'USER': 'cltbld', 09:54:34 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1471971216.845022-1881525037', 09:54:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:54:34 INFO - '_': '/tools/buildbot/bin/python'} 09:54:34 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/TtWoa8L8TjOWiu-gs17hsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 09:54:34 INFO - mozversion application_buildid: 20160823080458 09:54:34 INFO - mozversion application_changeset: 8381bc7a46811aa0de0d984cdb6f1cc5ce4c52c2 09:54:34 INFO - mozversion application_display_name: Nightly 09:54:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:54:34 INFO - mozversion application_name: Firefox 09:54:34 INFO - mozversion application_remotingname: firefox 09:54:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:54:34 INFO - mozversion application_vendor: Mozilla 09:54:34 INFO - mozversion application_version: 51.0a1 09:54:34 INFO - mozversion platform_buildid: 20160823080458 09:54:34 INFO - mozversion platform_changeset: 8381bc7a46811aa0de0d984cdb6f1cc5ce4c52c2 09:54:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:54:34 INFO - mozversion platform_version: 51.0a1 09:54:34 INFO - using testdate: 1471971274 09:54:34 INFO - actual date: 1471971274 09:54:34 INFO - starting webserver on 'localhost:44063' 09:54:34 INFO - SUITE-START | Running 2 tests 09:54:34 INFO - TEST-START | dromaeo_css 09:54:34 INFO - operating with platform_type : linux_ 09:54:34 INFO - Initialising browser for dromaeo_css test... 09:54:34 INFO - TEST-INFO | started process 15389 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9m9FIv/profile http://localhost:44063/getInfo.html) 09:54:39 INFO - PROCESS | 15389 | __metrics Screen width/height:1600/1200 09:54:39 INFO - PROCESS | 15389 | colorDepth:24 09:54:39 INFO - PROCESS | 15389 | Browser inner width/height: 1024/697 09:54:39 INFO - PROCESS | 15389 | __metrics 09:54:39 INFO - PROCESS | 15389 | 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" 09:54:39 INFO - PROCESS | 15389 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:54:40 INFO - PROCESS | 15389 | console.error: PushService: 09:54:40 INFO - PROCESS | 15389 | stateChangeProcessEnqueue: Error transitioning state 09:54:40 INFO - PROCESS | 15389 | UnknownError 09:54:41 INFO - TEST-INFO | 15389: exit 0 09:54:41 INFO - Browser initialized. 09:54:41 INFO - Running cycle 1/1 for dromaeo_css test... 09:54:41 INFO - TEST-INFO | started process 15470 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9m9FIv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:54:53 INFO - PROCESS | 15470 | RSS: Main: 184602624 09:54:53 INFO - PROCESS | 15470 | 09:55:45 INFO - PROCESS | 15470 | 1471971345293 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] 09:57:57 INFO - PROCESS | 15470 | Cycle 1(1): loaded http://localhost:44063/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44063/tests/dromaeo/cssquery-ext.html) 09:57:58 INFO - PROCESS | 15470 | RSS: Main: 264835072 09:57:58 INFO - PROCESS | 15470 | 10:01:01 INFO - PROCESS | 15470 | Cycle 1(1): loaded http://localhost:44063/tests/dromaeo/cssquery-ext.html (next: http://localhost:44063/tests/dromaeo/cssquery-jquery.html) 10:01:02 INFO - PROCESS | 15470 | RSS: Main: 275300352 10:01:02 INFO - PROCESS | 15470 | 10:04:04 INFO - PROCESS | 15470 | Cycle 1(1): loaded http://localhost:44063/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44063/tests/dromaeo/cssquery-mootools.html) 10:04:05 INFO - PROCESS | 15470 | RSS: Main: 220131328 10:04:05 INFO - PROCESS | 15470 | 10:07:07 INFO - PROCESS | 15470 | Cycle 1(1): loaded http://localhost:44063/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44063/tests/dromaeo/cssquery-prototype.html) 10:07:08 INFO - PROCESS | 15470 | RSS: Main: 218693632 10:07:08 INFO - PROCESS | 15470 | 10:10:11 INFO - PROCESS | 15470 | Cycle 1(1): loaded http://localhost:44063/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44063/tests/dromaeo/cssquery-yui.html) 10:10:11 INFO - PROCESS | 15470 | RSS: Main: 218628096 10:10:11 INFO - PROCESS | 15470 | 10:13:15 INFO - PROCESS | 15470 | Cycle 1(1): loaded http://localhost:44063/tests/dromaeo/cssquery-yui.html (next: http://localhost:44063/tests/dromaeo/cssquery-dojo.html) 10:13:15 INFO - PROCESS | 15470 | RSS: Main: 305532928 10:13:15 INFO - PROCESS | 15470 | 10:13:15 INFO - PROCESS | 15470 | __start_tp_report 10:13:15 INFO - PROCESS | 15470 | _x_x_mozilla_page_load 10:13:15 INFO - PROCESS | 15470 | _x_x_mozilla_page_load_details 10:13:15 INFO - PROCESS | 15470 | |i|pagename|runs| 10:13:15 INFO - PROCESS | 15470 | |0;dojo.html;2539.9619005714912;2559.7440255974416;2588.9223323300307;2592.987035064825;2609.2041927212194;4543.4547854257535;4598.770061496924;4619.168549661068;4671.135839869627;4732.2428411454175;4589.128065667521;4596.103759766846;4628.236341003739;4635.860924172281;4708.74101924394;4280.828766849322;4299.978500107511;4302;4310.719803212781;4429.11417716458;4371.27873900806;4374.475062992446;4377.080813029268;4381.561843815625;4401.691881568291;4250.04374015847;4280.807363668642;4287.035417031143;4312.54718254585;4374.475062992429;4273.337632666941;4311.223979683656;4324.286492728696;4333.631641310492;4341.088371442001;4196.979015104936;4204.348326009474;4230.725002874803;4267.8079486423185;4329.393884856091;4609.147307748078;4618.699784513996;4635.397398338195;4645.46577143626;4702.083093796711;4851.393575803025;4860.781264843055;4873.756312184412;4888.804447822083;4966.255061740731;4923.606111511071;4926.507349265081;4938.432080310774;4944.777485013183;4974.527419895104;4578.175928332866;4584.922543202345;4610.377599024156;4612.86161415158;4616.792244349012;4948.233023881304;4983.25251212321;5017.498250174954;5087.87280317995;5101.846944591668;4896.608271338285;4911.705297682151;4913.361263035782;4915.0415668944925;4964.578010869044;5000.424951130666;5001.424836143818;5009.273655319958;5009.849704508871;5028.270900719375;4816.783244753994;4887.36464259644;4933.963867587775;4943.901121977612;5026.220935754964;4933.58064564516;4941.629377796679;4944.184209605447;4944.431390390079;4992.825251116266;4165.520965088993;4167.5832416758085;4171.812268447927;4210.6841986850495;4222.619964203175;3628.528291322164;3634.164142247245;3644.3804553226014;3653.8538458461894;3663.413853783382;4334.436523251957;4354.150940566559;4398.186335527937;4410.933835992462;4411.889702757392;5003.074431230234;5003.724795136302;5006.249062640633;5014.373203349582;5060.468650791688;4272.038791271939;4279.40088387626;4299.763513006752;4335.34969754533;4341.848035318749;4415.779211039435;4416.514183439819;4431.490378606437;4481.036577135931;4482.8655140345845;4706.1999460091865;4708.764561771966;4713.717176969393;4714.693544919569;4777.4267087949665;4857.587105096107;5002.924956125734;5012.172991456368;5017.448080711192;5057.115004874206;4728.645351598712;4782.426108866958;4799.256115302133;4827.08285425768;4834.250691142878;4986.6509344347;4992.026554821775;4992.400911890596;4993.975030124826;5039.974800125976;5033.320501732219;5044.041632089891;5049.823256186016;5052.216906379517;5101.336826212569;4727;4773.546513081252;4786.904261914672;4814.662973591815;4900.191468407673;4814.325994360863;4820.060088282891;4820.325154478446;4820.855374338776;4880.072786170616;4748.976255118702;4762.166620841408;4772.737499437564;4787.2101103318955;4833.323334733211;4801.303810947463;4827.493113223061;4859.781309841136;4865.927011094907;4958.107540642719;4761.833335833229;4783.880402989953;4784.880377990439;4795.304680821331;4847.3698419206685 10:13:15 INFO - PROCESS | 15470 | |1;ext.html;549.7498638119656;568.2527476368573;577.615885436185;577.9219805326279;583.4894467341077;27721.445571088567;38899.41650875236;40079.599204008024;40103.79948100263;43353.13293734124;39734;40175.79912100443;40201.39697904534;40227.39658905112;40276.19447611053;7597.810054748634;7746.38028957682;7757.689692412297;7770.9222907771045;7798.610069496503;7362.484626076177;9684.806303873918;9914.950425247864;9929.156021738161;10208.64269750559;10010.649627263047;10088.69733907984;10093.192544596452;10098.798024039515;10170.898291017105;9904.554295056703;10001.09990100887;10010.749731256705;10015.098641122335;10015.69952901414;9814.558344874498;9863.950680246624;9869.407835529819;9881.456519891402;9927.950360248153;38120.80939595312;38456.23087538234;38515.22969540622;38540.614593853985;38562.61437385618;2872.770178385724;3025.9243518911985;3037.164779685582;3047.8476076196325;3117;29007.70992290071;29021.854890725623;29345.706542934724;29378.55932161019;29390;3264.820434876081;3326.600807903043;3355.0438125134465;3366.1416338833687;3429.742769292288;247949;248061;248294;248492;250763;30816.383672326876;51738;51815.74092129515;51872.22191667128;51917;31714.84142579272;33464.832675836464;33475.66524334774;33578.496322555184;33588.49617255743;13132.803007954888;13230.801537976939;13267.734645307233;13272.933635331954;13275.601731948056;9930.354526955725;10619.575216991389;10701.83947240792;10728.678139655824;10738.838917416246;7756.573388463576;7791.337736292366;7853.685852565947;7864.764057078297;7903.762887113396;3012.51799712045;3043.345680678665;3056.66376698563;3070.2324418895278;3117.719405253538;814.9307308878812;827.6482494939747;855.3969451536652;878.7715194049465;953.909378609031;26541.469170616867;28256.29359266035;28623.427531449255;28833.56749648757;29058;942.4157022645867;973.8101070291225;985.8619793228954;987.0573602209872;1015.2081376526321;15128.773068403983;15138.736277333932;15196.772048419283;15208;15426.84573154254;123660;123823;123980;124556;125108.37445812713;48846.26730599044;49415.752921235886;49487.25769113466;49517.752411237714;49566.50433495619;1091.9672409827876;1167.9124065694937;1188.3107797477442;1197.9880201197877;1209.4920133543933;25318;29221.85389073041;29277.707222927496;29286;29348.706512934597;40715.38926916158;41415;41425.79287103545;41441.1711765769;41500.37749433701;294773;295353;296856;298484;298943;22597;24149.517009659357;24745.62881556742;25956.740432595434;25963.740362596887;37386.86145954967;41839;41991;42246.78876605597;42685.78657106694;35147.12132196613;35192.12019699528;35283.470747938285;35334.46998295079;35928.64071359253;34971.65028349684;35463.645363546035;35599.46600800938;36307.00934345909;36694.44958325574;34555.481667774504;34666.306673865874;35575.11062223465;35824.8208758965;36026.63973360233;29930.401391972475;32261.354772903942;32552.34895302128;32707.509387359685;32766.67233327636;24375.51248975046;24443.877780610983;24847;25127.623085654097;25383.61924571096 10:13:15 INFO - PROCESS | 15470 | |2;jquery.html;364.8011833550715;368.85983326336;376.74946160803074;377.0893292698134;387.27386150966936;15842.128682922435;16766.497005089837;16964.236609352578;17049;17092.82907170928;16576.585585360343;17027.40404085857;17477.300907963665;17590.912045439756;17602.735958960628;5006.274090256919;5250.7112108834;5250.947490525104;5254.7635356409055;5255.159174532076;3667.7065834733157;3866.7679939203736;5079.1365467870555;5851.327097383792;6082.9391706082815;6156.445919867211;6164.445199932005;6169;6173.135760993465;6174.444300012998;5926.970365148169;6114.602550834204;6122.387761223887;6130.509559235251;6131.601445906002;5133.640645154841;5269.0252303324005;5370.221317908881;5376.086065368897;5376.40859505458;20385.18459261628;20952.266670666453;20990.5801883963;21229.68155477669;21234.8147777833;1872.691005984011;2200;2309.364924645719;2409.33743220614;2491.700995880488;13164.341782910911;13315.134516256412;13396;13454.327283635877;13964.231967241798;1777.3512667876262;1789.4363275568155;1816.5095424235383;1836.9540761481069;1942.5920556683113;63376;68742.65628671875;68792.65603672;69527;69924.30075699229;9672.903270967201;9969.40183588987;10028.548715307828;10054;10158.917421928487;13556.59330220095;13562.93218533901;13568.118072325464;13584;13588.796168057486;7014.508984371147;7183.42532597391;7322.597257150801;7403.85192296151;7431.516951398142;6835.897461538081;6998.825029374307;7174.641267936582;7177.4258059355125;7450.590217538087;4157.376393540993;4198.895027624334;4243.766592837362;4358.4769827620885;4401.207782599099;1662.709025920459;1698.9915050424668;1752.8422441980283;1791.802901680814;1799.262302456013;796.2077732656045;804.1194891593696;841.2891107014563;863.9654413823376;936.7798567336671;16179.271932763055;16639.334426622798;16744.079075650956;16799.32802687879;17808.732869006973;818.1123481023157;844.6536919862949;871.172386233081;877.9165979231963;883.8453270677605;9161;9797.755056123653;9846;9874.50627468638;9933.701988940198;379516;381040;426413;429089;433762;79397;81279.18720812716;83098.58450707707;83633.16366836254;85798;865.7272959017889;912.2975309012156;935.0509233128245;935.8081593273363;936.9906300936904;11679.591214307458;14704.485343012942;15538.766918496458;16263.186840657683;16499.422520211734;39446.40830387604;39721.60278397179;40121.79939100286;40500.39249411202;41238.79380603078;48540.5145948536;49493.29976974879;51346.22980655368;51373.48626513687;51448;6925.238223795479;7087.255838137127;7134.250903655042;7254.89117663246;7335.376492997942;7989.760307190793;8089.069756977788;10631.096356809758;11959.820602690792;12122.27266364021;9965.202783777135;9998.200143988319;10248.180145588483;10494.947525262325;10748.408837514013;10126.341787783771;10144.847827282449;10244.180465562886;10358.326708763907;10728.302660327054;9963.850542242017;10242.334248273839;10320.27758056959;10724.839127412939;11075.889241107487;7356.117265928123;7670.890505110916;7671.462997590115;7829.804254893673;7866.685332586632;9748.951255243679;10262;10273.075423211947;10274.33216840903;10556.577736890438 10:13:15 INFO - PROCESS | 15470 | |3;mootools.html;1338.1903948111396;1373.025152141979;1408.8238970128734;1613.3465946291756;1625.4554724167403;6663.100481435004;6848.486363522731;6989.266127056662;7477.14012888518;7492.662830172641;7209.423246140309;7476.551406915589;7485.625718714056;7686.154523002465;7687.807804804883;2110.008296100834;2134.7331583552054;2134.9039293231763;2137.625915464795;2141.2184552638255;1828.552004758836;2050.784667609902;2051.805078517546;2087.0712532922857;2131.6163090643677;2055.691646253059;2106.29439137889;2107.3361891004283;2107.399391173516;2109.5253567947243;2047.1402011155276;2052.3842847145797;2054.5479994401207;2056.0850421562263;2085.7705652378227;2080.4798800299927;2083.4583008417767;2083.6874468829647;2084.270505323125;2092.0272073485903;7616.771496855104;7827.452078354518;7834.1382447931255;7835.333996610295;7835.333996610295;4269.7224680395675;4311.525732169459;4322.222000039991;4438.933415998763;4446.377507149002;2756.7105453927247;2832.6884042755282;2889.971100289012;2891.1471116020825;2897.463969165711;911.1662828511903;913.6117150211134;926.8543322209132;930.4928813796497;931.3899395895631;10258.79482410355;10263.79472410555;10264.589416423334;10274.178065754722;10289.588416463332;3729.5710993235584;3829.1193025604266;3988.282109220368;3990.700697447703;4033.9394909076386;8665.17680820321;8666.220040196413;8671.869921951049;8676.262517685942;8676.436031657922;4444.511103778582;4448.266036104072;4456.710313829655;4456.955430445719;4459.44256967879;4008.2785098682516;4070.4504891839815;4075.286824805647;4075.7962101895378;4077.571854955246;3511.94732079019;3540.362734707726;3565.3938830398893;3607.8917632471066;3630.074331045619;1026.7381817636604;1104.5636973395465;1139.5214010115772;1140.6977151054812;1143.5025763792776;770.6339488742802;790.9169537198511;817.627979269431;825.8224481736336;859.7592674051276;4970.801167953241;5031.924521132186;5114.693118412907;5116.74416279192;5343.65266257692;837.2883049407955;853.1468531468531;879.6305551668314;888.5424006636588;910.0899100899101;3461.4980827780337;3532.1875968527384;3587.8744243951337;3609.151849315409;3694.7413681042067;8768.640860666606;9062.728118156467;9098.454092754457;9467.242620590336;9468.14786669203;9321.906780932239;9331.020242874536;9334.25325973934;9344.95327523358;9347.766305842408;6953.6523173842115;6974.4420446364165;7130.322619351154;7161.104861892263;7197.4961752677855;5389.461053894579;5408.161734931092;5425.674459532441;5466.371367292653;5695.857603559944;8708.738737837875;8724.389292749447;8807.779805504657;8821.823563528822;8831.116888311117;8287.58562071906;8629.39594228398;8643.394962352575;8661.090585488684;8940.15068568485;6150.969245153925;6260.467860231931;6266.968665156645;6289.811305660837;6296.150019747275;7207.387372073433;7276.272372762682;7277.708891644275;7285.526440781332;7286.890696639449;6014.36849130835;6025.87948241024;6123.112148738497;6147.44672979434;6201.255849298113;6544.411003009752;6578.506612004215;6607.07500949877;6610.07458955737;6655.900161497679;5945.375735547878;6051.697415129138;6052.75788968454;6053.515718742578;6060.363661815446;4290.099079193279;4355.368471571541;4378.146261478981;4477.261251893401;4519.909601808011;4434.623057040188;4578.381918440968;4587.2201725706045;4692.906141877212;4728.527147285244 10:13:15 INFO - PROCESS | 15470 | |4;prototype.html;289.06775648533477;298.8759664739133;302.63834717512583;308.551058210304;309.25315363397397;4835.153848076586;4900.852974410765;4909.386326709166;4915.311856340115;4930.225118957177;4804.351412559304;4826.662133650646;4845.4427740809815;4860.781264843082;4879.657764273142;3604.6215147409603;3718.3678774608384;3740.214554943465;3807.9147442978756;3841.9039524011846;3810.8856734298015;3822.44574536692;3828.502294701685;3837.808109594509;3861.4787003754413;3775.2449510097954;3781.2626537825136;3793.1275806564367;3798.22136462026;3807.276617442691;3611.747177697562;3677.5035370225078;3761.1349389640263;3808.2383523295175;3817.141143242748;3377.392069427502;3380.647740903634;3381.780184288038;3389.6271410144864;3398.3882901077795;4676.181668208084;4692.601128904047;4702.835400760957;4703.576678098988;4704.411948506437;4214;4307.956920430787;4326.740395576244;4338.43600331958;4347.7173983690955;4964.6276529260085;4977.352944117241;4987.5760560352055;4988.900221995576;4998.200287953946;3652.3425783358985;3655.9580519552064;3658.5975542690285;3661.1945372018113;3663.6336366363416;5091.766728127665;5252.343457067866;5271.130263506517;5279.41926388097;5286.127788914824;3746.4380342948775;3756.549214094326;3760.8495660173285;3767.1900541383184;3785.6403641653997;3804.622111180512;3812.4471951566866;3818.885433437001;3830.9042273943373;3833.4058220975235;4313.654907607384;4321.286987647066;4323.589259020388;4337.522872484024;4351.73889566627;4836.250381190921;4962.6774259673;4970.676906001098;4975.4278258000795;5047.899042019139;1304;1322.93385330735;1323.384626148826;1330.6872884872048;1331.9943442700699;851.535912927456;852.3394369363668;856.8389831777976;860.2558786649503;871.7864123289835;4305.5048669402795;4368.143538995914;4377.518472967971;4398.956010439919;4460.464744230713;5127.307813445137;5139.743012849417;5173.051360724427;5188.351456067991;5211.530962213419;4398.582134697199;4494.5505449454795;4500.549945005473;4514.367988481616;4539.296409056601;2738.1374866917254;2747.8763455644544;2753.1740477856565;2757.2141939547532;2773.2234974207254;4879.658423910292;4880;4916.0905232532095;4917.532834380728;4925.162722337212;5020.5732512736095;5233.319668443078;5269.420363759983;5298.947010529922;5318.627696061239;4900.289458028566;4908.582770464479;4919.237518184687;4945.109880221451;4946.727929963887;5222.164453687392;5226.764795584132;5228.843134705965;5236.214567814706;5240.737963101754;4952.059108769322;5047;5094.7962081516325;5097.088591778083;5115.335006449138;4853.247746599282;4878.9512104878495;4892.217245240744;4900.77014958186;4912.901741965069;3746.6815320698047;3753.455748916337;3764.6235376462137;3783.791891445997;3787.8295476704166;5020.824271150492;5186.533212010786;5241.68549887008;5243.161094224905;5246.895062098813;5032.974835125948;5047.899042019212;5054.721990290569;5068.873278168076;5076.593872490266;5017.774200160929;5077.390713114302;5088.0078384714625;5088.099783123584;5092.592592592658;4810.5670489656095;4907.33750943618;4947.752612369439;4950.203135228584;5033.169527028;4783.330333753208;4878.707277563358;5033.572146367454;5053.823116190915;5068.518490743373;4909.091818013679;4918.729469879191;4944.381952255968;4966.230234313687;4975.776090076028 10:13:15 INFO - PROCESS | 15470 | |5;yui.html;593.4421643654965;597.423486335686;616.7471336751933;695.3220609905342;697.9825504362391;12687.175333603309;13931.37308821103;13948.442062317508;13949.093308934913;13965.581032569014;13295.800562991562;13374.66563335917;13429;13476.3261836908;13489.46042158315;608.6135304081896;621.8880601491752;728.3481284250593;738.6786747764726;759.5215014540831;752.9811754706121;768.2509553185655;769.6459628570836;769.8113962079299;770.3721467004374;800.6957356204634;807.6728924785442;807.7576726981882;808.2119933065273;808.3210103513048;648.2739331948248;780.1808101493409;797.2306724011299;809.4333966223637;809.9433039687224;587.7825204674255;588.2852334413708;588.6615196262167;589.666838236395;590.400743245606;12069.155159138863;12086.33525156116;12099.274043557327;12108.515659373614;12113.39433028345;12262.325572093532;12488.375581220902;12855.421506032251;13194.208347499181;13300.002499812554;11772.587959421464;11801.878821511942;11909.702257443547;12153.939230303791;12246.571370002097;3231.0952933178746;3369.1913940654313;4065.715399922007;4096.221717873625;4181.770002649853;62065;62233.688831555555;62259.68870155665;63099.36900630981;63431;9889.554970026365;10063.245256605784;10156.898431015743;10176.796464070678;10181.236407269484;17785.644287114443;17809.910950445166;17810.821891780917;17818.19818108162;17829.7325540117;6566.5403421760975;6689.899651505231;6695.363940425652;6947.79156625302;6968.233494315621;3708.7686669219343;3776.3957766757185;3817.9809100954317;3836.5971572984995;3872;2864.7135286471603;2976.37496125816;2998.770504093311;3001.8949336773107;3009.8043627164166;506.48338694532106;518.1709265175764;520.9036328279204;526.3131613244676;534.7513406266105;500.624531601299;531.981380651683;537.3605409562608;557.0585710149834;563.7096895099028;7314.268573142643;7883.921160788434;7936.23185524946;8127.309178719756;8333.33333333332;492.7979528393413;536.1421725239663;555.1478480532363;558.9720513974366;562.4235158962097;3724.5902950675404;3786.848526058982;3796.544414670202;3822.6177382261553;3853.9887139591137;98135.50932245293;98845;101371;101395;104528.47735761425;51075.48924510782;52022;52415;52438.47561524412;75607.24392756113;48841.51158488441;52147.73926130345;60337.39662603405;73154.17114572179;76058.23941760622;6950.965245173742;7111.857762844817;7345.155307139534;7371.262873712586;7374.483786134919;43803;46147;47062.05875882532;47072.05855882795;47212.527874720814;39557;41332;62642.37357626366;65666;66750;10018.799624007333;10108.090271875566;10452.425116618659;10849.783004340026;11306.434678265889;12047.638570842888;12540.372981350714;12632.873671263169;12827.294498802656;13463.596092117252;11093.889061109285;11739.647810565697;11809.984605234262;12001.519939202333;12141.15011949155;11141.832872506757;11309.20835541537;11499.137564682514;11717.414129293671;11852.822207667065;11608.709782255512;11638.767224655629;11697.941510292394;12304.200226985216;12316.199447035913;9437.764055898657;9547.856782148134;9584.37701549397;9788;10179.49102544855;9248.768780780534;9679.274054445805;9694.175995040501;9964.900350996397;10002.549885255326 10:13:15 INFO - PROCESS | 15470 | __end_tp_report 10:13:15 INFO - PROCESS | 15470 | __start_cc_report 10:13:15 INFO - PROCESS | 15470 | _x_x_mozilla_cycle_collect,1066 10:13:15 INFO - PROCESS | 15470 | __end_cc_report 10:13:15 INFO - PROCESS | 15470 | __startTimestamp1471972395512__endTimestamp 10:13:15 INFO - PROCESS | 15470 | 10:13:15 INFO - PROCESS | 15470 | ------- Summary: start ------- 10:13:15 INFO - PROCESS | 15470 | Number of tests: 6 10:13:15 INFO - PROCESS | 15470 | 10:13:15 INFO - PROCESS | 15470 | [#0] dojo.html Cycles:165 Average:4604.04 Median:4761.83 stddev:483.21 (10.1%) stddev-sans-first:456.76 10:13:15 INFO - PROCESS | 15470 | Values: 2540.0 2559.7 2588.9 2593.0 2609.2 4543.5 4598.8 4619.2 4671.1 4732.2 4589.1 4596.1 4628.2 4635.9 4708.7 4280.8 4300.0 4302.0 4310.7 4429.1 4371.3 4374.5 4377.1 4381.6 4401.7 4250.0 4280.8 4287.0 4312.5 4374.5 4273.3 4311.2 4324.3 4333.6 4341.1 4197.0 4204.3 4230.7 4267.8 4329.4 4609.1 4618.7 4635.4 4645.5 4702.1 4851.4 4860.8 4873.8 4888.8 4966.3 4923.6 4926.5 4938.4 4944.8 4974.5 4578.2 4584.9 4610.4 4612.9 4616.8 4948.2 4983.3 5017.5 5087.9 5101.8 4896.6 4911.7 4913.4 4915.0 4964.6 5000.4 5001.4 5009.3 5009.8 5028.3 4816.8 4887.4 4934.0 4943.9 5026.2 4933.6 4941.6 4944.2 4944.4 4992.8 4165.5 4167.6 4171.8 4210.7 4222.6 3628.5 3634.2 3644.4 3653.9 3663.4 4334.4 4354.2 4398.2 4410.9 4411.9 5003.1 5003.7 5006.2 5014.4 5060.5 4272.0 4279.4 4299.8 4335.3 4341.8 4415.8 4416.5 4431.5 4481.0 4482.9 4706.2 4708.8 4713.7 4714.7 4777.4 4857.6 5002.9 5012.2 5017.4 5057.1 4728.6 4782.4 4799.3 4827.1 4834.3 4986.7 4992.0 4992.4 4994.0 5040.0 5033.3 5044.0 5049.8 5052.2 5101.3 4727.0 4773.5 4786.9 4814.7 4900.2 4814.3 4820.1 4820.3 4820.9 4880.1 4749.0 4762.2 4772.7 4787.2 4833.3 4801.3 4827.5 4859.8 4865.9 4958.1 4761.8 4783.9 4784.9 4795.3 4847.4 10:13:15 INFO - PROCESS | 15470 | 10:13:15 INFO - PROCESS | 15470 | [#1] ext.html Cycles:180 Average:38336.73 Median:33470.25 stddev:61621.50 (184.1%) stddev-sans-first:61729.05 10:13:15 INFO - PROCESS | 15470 | Values: 549.7 568.3 577.6 577.9 583.5 27721.4 38899.4 40079.6 40103.8 43353.1 39734.0 40175.8 40201.4 40227.4 40276.2 7597.8 7746.4 7757.7 7770.9 7798.6 7362.5 9684.8 9915.0 9929.2 10208.6 10010.6 10088.7 10093.2 10098.8 10170.9 9904.6 10001.1 10010.7 10015.1 10015.7 9814.6 9864.0 9869.4 9881.5 9928.0 38120.8 38456.2 38515.2 38540.6 38562.6 2872.8 3025.9 3037.2 3047.8 3117.0 29007.7 29021.9 29345.7 29378.6 29390.0 3264.8 3326.6 3355.0 3366.1 3429.7 247949.0 248061.0 248294.0 248492.0 250763.0 30816.4 51738.0 51815.7 51872.2 51917.0 31714.8 33464.8 33475.7 33578.5 33588.5 13132.8 13230.8 13267.7 13272.9 13275.6 9930.4 10619.6 10701.8 10728.7 10738.8 7756.6 7791.3 7853.7 7864.8 7903.8 3012.5 3043.3 3056.7 3070.2 3117.7 814.9 827.6 855.4 878.8 953.9 26541.5 28256.3 28623.4 28833.6 29058.0 942.4 973.8 985.9 987.1 1015.2 15128.8 15138.7 15196.8 15208.0 15426.8 123660.0 123823.0 123980.0 124556.0 125108.4 48846.3 49415.8 49487.3 49517.8 49566.5 1092.0 1167.9 1188.3 1198.0 1209.5 25318.0 29221.9 29277.7 29286.0 29348.7 40715.4 41415.0 41425.8 41441.2 41500.4 294773.0 295353.0 296856.0 298484.0 298943.0 22597.0 24149.5 24745.6 25956.7 25963.7 37386.9 41839.0 41991.0 42246.8 42685.8 35147.1 35192.1 35283.5 35334.5 35928.6 34971.7 35463.6 35599.5 36307.0 36694.4 34555.5 34666.3 35575.1 35824.8 36026.6 29930.4 32261.4 32552.3 32707.5 32766.7 24375.5 24443.9 24847.0 25127.6 25383.6 10:13:15 INFO - PROCESS | 15470 | 10:13:15 INFO - PROCESS | 15470 | [#2] jquery.html Cycles:180 Average:25173.28 Median:431425.50 stddev:67788.11 (15.7%) stddev-sans-first:67952.68 10:13:15 INFO - PROCESS | 15470 | Values: 364.8 368.9 376.7 377.1 387.3 15842.1 16766.5 16964.2 17049.0 17092.8 16576.6 17027.4 17477.3 17590.9 17602.7 5006.3 5250.7 5250.9 5254.8 5255.2 3667.7 3866.8 5079.1 5851.3 6082.9 6156.4 6164.4 6169.0 6173.1 6174.4 5927.0 6114.6 6122.4 6130.5 6131.6 5133.6 5269.0 5370.2 5376.1 5376.4 20385.2 20952.3 20990.6 21229.7 21234.8 1872.7 2200.0 2309.4 2409.3 2491.7 13164.3 13315.1 13396.0 13454.3 13964.2 1777.4 1789.4 1816.5 1837.0 1942.6 63376.0 68742.7 68792.7 69527.0 69924.3 9672.9 9969.4 10028.5 10054.0 10158.9 13556.6 13562.9 13568.1 13584.0 13588.8 7014.5 7183.4 7322.6 7403.9 7431.5 6835.9 6998.8 7174.6 7177.4 7450.6 4157.4 4198.9 4243.8 4358.5 4401.2 1662.7 1699.0 1752.8 1791.8 1799.3 796.2 804.1 841.3 864.0 936.8 16179.3 16639.3 16744.1 16799.3 17808.7 818.1 844.7 871.2 877.9 883.8 9161.0 9797.8 9846.0 9874.5 9933.7 379516.0 381040.0 426413.0 429089.0 433762.0 79397.0 81279.2 83098.6 83633.2 85798.0 865.7 912.3 935.1 935.8 937.0 11679.6 14704.5 15538.8 16263.2 16499.4 39446.4 39721.6 40121.8 40500.4 41238.8 48540.5 49493.3 51346.2 51373.5 51448.0 6925.2 7087.3 7134.3 7254.9 7335.4 7989.8 8089.1 10631.1 11959.8 12122.3 9965.2 9998.2 10248.2 10494.9 10748.4 10126.3 10144.8 10244.2 10358.3 10728.3 9963.9 10242.3 10320.3 10724.8 11075.9 7356.1 7670.9 7671.5 7829.8 7866.7 9749.0 10262.0 10273.1 10274.3 10556.6 10:13:15 INFO - PROCESS | 15470 | 10:13:15 INFO - PROCESS | 15470 | [#3] mootools.html Cycles:180 Average:4960.46 Median:5398.81 stddev:2762.50 (51.2%) stddev-sans-first:2756.84 10:13:15 INFO - PROCESS | 15470 | Values: 1338.2 1373.0 1408.8 1613.3 1625.5 6663.1 6848.5 6989.3 7477.1 7492.7 7209.4 7476.6 7485.6 7686.2 7687.8 2110.0 2134.7 2134.9 2137.6 2141.2 1828.6 2050.8 2051.8 2087.1 2131.6 2055.7 2106.3 2107.3 2107.4 2109.5 2047.1 2052.4 2054.5 2056.1 2085.8 2080.5 2083.5 2083.7 2084.3 2092.0 7616.8 7827.5 7834.1 7835.3 7835.3 4269.7 4311.5 4322.2 4438.9 4446.4 2756.7 2832.7 2890.0 2891.1 2897.5 911.2 913.6 926.9 930.5 931.4 10258.8 10263.8 10264.6 10274.2 10289.6 3729.6 3829.1 3988.3 3990.7 4033.9 8665.2 8666.2 8671.9 8676.3 8676.4 4444.5 4448.3 4456.7 4457.0 4459.4 4008.3 4070.5 4075.3 4075.8 4077.6 3511.9 3540.4 3565.4 3607.9 3630.1 1026.7 1104.6 1139.5 1140.7 1143.5 770.6 790.9 817.6 825.8 859.8 4970.8 5031.9 5114.7 5116.7 5343.7 837.3 853.1 879.6 888.5 910.1 3461.5 3532.2 3587.9 3609.2 3694.7 8768.6 9062.7 9098.5 9467.2 9468.1 9321.9 9331.0 9334.3 9345.0 9347.8 6953.7 6974.4 7130.3 7161.1 7197.5 5389.5 5408.2 5425.7 5466.4 5695.9 8708.7 8724.4 8807.8 8821.8 8831.1 8287.6 8629.4 8643.4 8661.1 8940.2 6151.0 6260.5 6267.0 6289.8 6296.2 7207.4 7276.3 7277.7 7285.5 7286.9 6014.4 6025.9 6123.1 6147.4 6201.3 6544.4 6578.5 6607.1 6610.1 6655.9 5945.4 6051.7 6052.8 6053.5 6060.4 4290.1 4355.4 4378.1 4477.3 4519.9 4434.6 4578.4 4587.2 4692.9 4728.5 10:13:15 INFO - PROCESS | 15470 | 10:13:15 INFO - PROCESS | 15470 | [#4] prototype.html Cycles:180 Average:4205.91 Median:4840.85 stddev:1205.21 (24.9%) stddev-sans-first:1172.19 10:13:15 INFO - PROCESS | 15470 | Values: 289.1 298.9 302.6 308.6 309.3 4835.2 4900.9 4909.4 4915.3 4930.2 4804.4 4826.7 4845.4 4860.8 4879.7 3604.6 3718.4 3740.2 3807.9 3841.9 3810.9 3822.4 3828.5 3837.8 3861.5 3775.2 3781.3 3793.1 3798.2 3807.3 3611.7 3677.5 3761.1 3808.2 3817.1 3377.4 3380.6 3381.8 3389.6 3398.4 4676.2 4692.6 4702.8 4703.6 4704.4 4214.0 4308.0 4326.7 4338.4 4347.7 4964.6 4977.4 4987.6 4988.9 4998.2 3652.3 3656.0 3658.6 3661.2 3663.6 5091.8 5252.3 5271.1 5279.4 5286.1 3746.4 3756.5 3760.8 3767.2 3785.6 3804.6 3812.4 3818.9 3830.9 3833.4 4313.7 4321.3 4323.6 4337.5 4351.7 4836.3 4962.7 4970.7 4975.4 5047.9 1304.0 1322.9 1323.4 1330.7 1332.0 851.5 852.3 856.8 860.3 871.8 4305.5 4368.1 4377.5 4399.0 4460.5 5127.3 5139.7 5173.1 5188.4 5211.5 4398.6 4494.6 4500.5 4514.4 4539.3 2738.1 2747.9 2753.2 2757.2 2773.2 4879.7 4880.0 4916.1 4917.5 4925.2 5020.6 5233.3 5269.4 5298.9 5318.6 4900.3 4908.6 4919.2 4945.1 4946.7 5222.2 5226.8 5228.8 5236.2 5240.7 4952.1 5047.0 5094.8 5097.1 5115.3 4853.2 4879.0 4892.2 4900.8 4912.9 3746.7 3753.5 3764.6 3783.8 3787.8 5020.8 5186.5 5241.7 5243.2 5246.9 5033.0 5047.9 5054.7 5068.9 5076.6 5017.8 5077.4 5088.0 5088.1 5092.6 4810.6 4907.3 4947.8 4950.2 5033.2 4783.3 4878.7 5033.6 5053.8 5068.5 4909.1 4918.7 4944.4 4966.2 4975.8 10:13:15 INFO - PROCESS | 15470 | 10:13:15 INFO - PROCESS | 15470 | [#5] yui.html Cycles:180 Average:16545.59 Median:48027.02 stddev:23153.91 (48.2%) stddev-sans-first:23187.88 10:13:15 INFO - PROCESS | 15470 | Values: 593.4 597.4 616.7 695.3 698.0 12687.2 13931.4 13948.4 13949.1 13965.6 13295.8 13374.7 13429.0 13476.3 13489.5 608.6 621.9 728.3 738.7 759.5 753.0 768.3 769.6 769.8 770.4 800.7 807.7 807.8 808.2 808.3 648.3 780.2 797.2 809.4 809.9 587.8 588.3 588.7 589.7 590.4 12069.2 12086.3 12099.3 12108.5 12113.4 12262.3 12488.4 12855.4 13194.2 13300.0 11772.6 11801.9 11909.7 12153.9 12246.6 3231.1 3369.2 4065.7 4096.2 4181.8 62065.0 62233.7 62259.7 63099.4 63431.0 9889.6 10063.2 10156.9 10176.8 10181.2 17785.6 17809.9 17810.8 17818.2 17829.7 6566.5 6689.9 6695.4 6947.8 6968.2 3708.8 3776.4 3818.0 3836.6 3872.0 2864.7 2976.4 2998.8 3001.9 3009.8 506.5 518.2 520.9 526.3 534.8 500.6 532.0 537.4 557.1 563.7 7314.3 7883.9 7936.2 8127.3 8333.3 492.8 536.1 555.1 559.0 562.4 3724.6 3786.8 3796.5 3822.6 3854.0 98135.5 98845.0 101371.0 101395.0 104528.5 51075.5 52022.0 52415.0 52438.5 75607.2 48841.5 52147.7 60337.4 73154.2 76058.2 6951.0 7111.9 7345.2 7371.3 7374.5 43803.0 46147.0 47062.1 47072.1 47212.5 39557.0 41332.0 62642.4 65666.0 66750.0 10018.8 10108.1 10452.4 10849.8 11306.4 12047.6 12540.4 12632.9 12827.3 13463.6 11093.9 11739.6 11810.0 12001.5 12141.2 11141.8 11309.2 11499.1 11717.4 11852.8 11608.7 11638.8 11697.9 12304.2 12316.2 9437.8 9547.9 9584.4 9788.0 10179.5 9248.8 9679.3 9694.2 9964.9 10002.5 10:13:15 INFO - PROCESS | 15470 | -------- Summary: end -------- 10:13:15 INFO - PROCESS | 15470 | 10:13:16 INFO - TEST-INFO | 15470: exit 0 10:13:16 INFO - TEST-OK | dromaeo_css | took 1121738ms 10:13:16 INFO - TEST-START | kraken 10:13:16 INFO - operating with platform_type : linux_ 10:13:16 INFO - Initialising browser for kraken test... 10:13:16 INFO - TEST-INFO | started process 15775 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpF1HP5I/profile http://localhost:44063/getInfo.html) 10:13:21 INFO - PROCESS | 15775 | __metrics Screen width/height:1600/1200 10:13:21 INFO - PROCESS | 15775 | colorDepth:24 10:13:21 INFO - PROCESS | 15775 | Browser inner width/height: 1024/697 10:13:21 INFO - PROCESS | 15775 | __metrics 10:13:21 INFO - PROCESS | 15775 | 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" 10:13:21 INFO - PROCESS | 15775 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:13:22 INFO - PROCESS | 15775 | console.error: PushService: 10:13:22 INFO - PROCESS | 15775 | stateChangeProcessEnqueue: Error transitioning state 10:13:22 INFO - PROCESS | 15775 | UnknownError 10:13:22 INFO - TEST-INFO | 15775: exit 0 10:13:22 INFO - Browser initialized. 10:13:22 INFO - Running cycle 1/1 for kraken test... 10:13:22 INFO - TEST-INFO | started process 15853 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpF1HP5I/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:13:35 INFO - PROCESS | 15853 | RSS: Main: 184987648 10:13:35 INFO - PROCESS | 15853 | 10:13:37 INFO - PROCESS | 15853 | Cycle 1(1): loaded http://localhost:44063/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44063/tests/kraken/driver.html?testName=audio-beat-detection) 10:13:38 INFO - PROCESS | 15853 | RSS: Main: 236752896 10:13:38 INFO - PROCESS | 15853 | 10:13:41 INFO - PROCESS | 15853 | Cycle 1(1): loaded http://localhost:44063/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44063/tests/kraken/driver.html?testName=audio-dft) 10:13:42 INFO - PROCESS | 15853 | RSS: Main: 226779136 10:13:42 INFO - PROCESS | 15853 | 10:13:45 INFO - PROCESS | 15853 | Cycle 1(1): loaded http://localhost:44063/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44063/tests/kraken/driver.html?testName=audio-fft) 10:13:46 INFO - PROCESS | 15853 | RSS: Main: 306991104 10:13:46 INFO - PROCESS | 15853 | 10:13:48 INFO - PROCESS | 15853 | Cycle 1(1): loaded http://localhost:44063/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44063/tests/kraken/driver.html?testName=audio-oscillator) 10:13:48 INFO - PROCESS | 15853 | RSS: Main: 214839296 10:13:48 INFO - PROCESS | 15853 | 10:13:51 INFO - PROCESS | 15853 | Cycle 1(1): loaded http://localhost:44063/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44063/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:13:51 INFO - PROCESS | 15853 | RSS: Main: 216829952 10:13:51 INFO - PROCESS | 15853 | 10:13:55 INFO - PROCESS | 15853 | Cycle 1(1): loaded http://localhost:44063/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44063/tests/kraken/driver.html?testName=imaging-darkroom) 10:13:55 INFO - PROCESS | 15853 | RSS: Main: 256266240 10:13:55 INFO - PROCESS | 15853 | 10:13:59 INFO - PROCESS | 15853 | Cycle 1(1): loaded http://localhost:44063/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44063/tests/kraken/driver.html?testName=imaging-desaturate) 10:13:59 INFO - PROCESS | 15853 | RSS: Main: 255344640 10:13:59 INFO - PROCESS | 15853 | 10:14:02 INFO - PROCESS | 15853 | Cycle 1(1): loaded http://localhost:44063/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44063/tests/kraken/driver.html?testName=json-parse-financial) 10:14:03 INFO - PROCESS | 15853 | RSS: Main: 255717376 10:14:03 INFO - PROCESS | 15853 | 10:14:05 INFO - PROCESS | 15853 | Cycle 1(1): loaded http://localhost:44063/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44063/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:14:05 INFO - PROCESS | 15853 | RSS: Main: 218165248 10:14:05 INFO - PROCESS | 15853 | 10:14:07 INFO - PROCESS | 15853 | Cycle 1(1): loaded http://localhost:44063/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44063/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:14:08 INFO - PROCESS | 15853 | RSS: Main: 225206272 10:14:08 INFO - PROCESS | 15853 | 10:14:10 INFO - PROCESS | 15853 | Cycle 1(1): loaded http://localhost:44063/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44063/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:14:11 INFO - PROCESS | 15853 | RSS: Main: 224100352 10:14:11 INFO - PROCESS | 15853 | 10:14:13 INFO - PROCESS | 15853 | Cycle 1(1): loaded http://localhost:44063/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44063/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:14:14 INFO - PROCESS | 15853 | RSS: Main: 218923008 10:14:14 INFO - PROCESS | 15853 | 10:14:17 INFO - PROCESS | 15853 | Cycle 1(1): loaded http://localhost:44063/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44063/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:14:18 INFO - PROCESS | 15853 | RSS: Main: 222298112 10:14:18 INFO - PROCESS | 15853 | 10:14:20 INFO - PROCESS | 15853 | Cycle 1(1): loaded http://localhost:44063/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44063/tests/kraken/driver.html?testName=ai-astar) 10:14:20 INFO - PROCESS | 15853 | RSS: Main: 274276352 10:14:20 INFO - PROCESS | 15853 | 10:14:20 INFO - PROCESS | 15853 | __start_tp_report 10:14:20 INFO - PROCESS | 15853 | _x_x_mozilla_page_load 10:14:20 INFO - PROCESS | 15853 | _x_x_mozilla_page_load_details 10:14:20 INFO - PROCESS | 15853 | |i|pagename|runs| 10:14:20 INFO - PROCESS | 15853 | |0;ai-astar;115;115;129;115;114;114;112;114;115;115 10:14:20 INFO - PROCESS | 15853 | |1;audio-beat-detection;148;126;146;193;121;158;152;124;193;127 10:14:20 INFO - PROCESS | 15853 | |2;audio-dft;163;162;161;162;162;162;163;162;164;160 10:14:20 INFO - PROCESS | 15853 | |3;audio-fft;76;76;77;159;76;76;75;77;172;75 10:14:20 INFO - PROCESS | 15853 | |4;audio-oscillator;87;86;150;89;88;88;144;86;87;137 10:14:20 INFO - PROCESS | 15853 | |5;imaging-gaussian-blur;116;117;118;118;118;119;118;118;117;117 10:14:20 INFO - PROCESS | 15853 | |6;imaging-darkroom;147;146;146;146;146;146;146;146;146;146 10:14:20 INFO - PROCESS | 15853 | |7;imaging-desaturate;95;94;94;95;95;94;95;96;94;95 10:14:20 INFO - PROCESS | 15853 | |8;json-parse-financial;68;67;69;68;68;70;68;67;66;69 10:14:20 INFO - PROCESS | 15853 | |9;json-stringify-tinderbox;65;66;64;66;65;64;66;65;66;66 10:14:20 INFO - PROCESS | 15853 | |10;stanford-crypto-aes;85;89;91;82;89;81;81;82;82;82 10:14:20 INFO - PROCESS | 15853 | |11;stanford-crypto-ccm;132;133;140;131;135;138;131;133;146;130 10:14:20 INFO - PROCESS | 15853 | |12;stanford-crypto-pbkdf2;177;176;174;178;175;178;181;174;177;174 10:14:20 INFO - PROCESS | 15853 | |13;stanford-crypto-sha256-iterative;69;68;73;73;69;69;69;73;68;71 10:14:20 INFO - PROCESS | 15853 | __end_tp_report 10:14:20 INFO - PROCESS | 15853 | __start_cc_report 10:14:20 INFO - PROCESS | 15853 | _x_x_mozilla_cycle_collect,2007 10:14:20 INFO - PROCESS | 15853 | __end_cc_report 10:14:20 INFO - PROCESS | 15853 | __startTimestamp1471972460299__endTimestamp 10:14:20 INFO - PROCESS | 15853 | 10:14:20 INFO - PROCESS | 15853 | ------- Summary: start ------- 10:14:20 INFO - PROCESS | 15853 | Number of tests: 14 10:14:20 INFO - PROCESS | 15853 | 10:14:20 INFO - PROCESS | 15853 | [#0] ai-astar Cycles:10 Average:115.80 Median:115.00 stddev:4.73 (4.1%) stddev-sans-first:5.01 10:14:20 INFO - PROCESS | 15853 | Values: 115.0 115.0 129.0 115.0 114.0 114.0 112.0 114.0 115.0 115.0 10:14:20 INFO - PROCESS | 15853 | 10:14:20 INFO - PROCESS | 15853 | [#1] audio-beat-detection Cycles:10 Average:148.80 Median:150.00 stddev:26.65 (17.8%) stddev-sans-first:28.27 10:14:20 INFO - PROCESS | 15853 | Values: 148.0 126.0 146.0 193.0 121.0 158.0 152.0 124.0 193.0 127.0 10:14:20 INFO - PROCESS | 15853 | 10:14:20 INFO - PROCESS | 15853 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:1.10 (0.7%) stddev-sans-first:1.12 10:14:20 INFO - PROCESS | 15853 | Values: 163.0 162.0 161.0 162.0 162.0 162.0 163.0 162.0 164.0 160.0 10:14:20 INFO - PROCESS | 15853 | 10:14:20 INFO - PROCESS | 15853 | [#3] audio-fft Cycles:10 Average:93.90 Median:76.00 stddev:37.87 (49.8%) stddev-sans-first:39.61 10:14:20 INFO - PROCESS | 15853 | Values: 76.0 76.0 77.0 159.0 76.0 76.0 75.0 77.0 172.0 75.0 10:14:20 INFO - PROCESS | 15853 | 10:14:20 INFO - PROCESS | 15853 | [#4] audio-oscillator Cycles:10 Average:104.20 Median:87.00 stddev:27.42 (31.5%) stddev-sans-first:28.37 10:14:20 INFO - PROCESS | 15853 | Values: 87.0 86.0 150.0 89.0 88.0 88.0 144.0 86.0 87.0 137.0 10:14:20 INFO - PROCESS | 15853 | 10:14:20 INFO - PROCESS | 15853 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.84 (0.7%) stddev-sans-first:0.67 10:14:20 INFO - PROCESS | 15853 | Values: 116.0 117.0 118.0 118.0 118.0 119.0 118.0 118.0 117.0 117.0 10:14:20 INFO - PROCESS | 15853 | 10:14:20 INFO - PROCESS | 15853 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.00 10:14:20 INFO - PROCESS | 15853 | Values: 147.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 10:14:20 INFO - PROCESS | 15853 | 10:14:20 INFO - PROCESS | 15853 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 10:14:20 INFO - PROCESS | 15853 | Values: 95.0 94.0 94.0 95.0 95.0 94.0 95.0 96.0 94.0 95.0 10:14:20 INFO - PROCESS | 15853 | 10:14:20 INFO - PROCESS | 15853 | [#8] json-parse-financial Cycles:10 Average:68.00 Median:68.00 stddev:1.15 (1.7%) stddev-sans-first:1.22 10:14:20 INFO - PROCESS | 15853 | Values: 68.0 67.0 69.0 68.0 68.0 70.0 68.0 67.0 66.0 69.0 10:14:20 INFO - PROCESS | 15853 | 10:14:20 INFO - PROCESS | 15853 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:66.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 10:14:20 INFO - PROCESS | 15853 | Values: 65.0 66.0 64.0 66.0 65.0 64.0 66.0 65.0 66.0 66.0 10:14:20 INFO - PROCESS | 15853 | 10:14:20 INFO - PROCESS | 15853 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:83.50 stddev:3.84 (4.6%) stddev-sans-first:4.06 10:14:20 INFO - PROCESS | 15853 | Values: 85.0 89.0 91.0 82.0 89.0 81.0 81.0 82.0 82.0 82.0 10:14:20 INFO - PROCESS | 15853 | 10:14:20 INFO - PROCESS | 15853 | [#11] stanford-crypto-ccm Cycles:10 Average:134.90 Median:134.00 stddev:5.04 (3.8%) stddev-sans-first:5.24 10:14:20 INFO - PROCESS | 15853 | Values: 132.0 133.0 140.0 131.0 135.0 138.0 131.0 133.0 146.0 130.0 10:14:20 INFO - PROCESS | 15853 | 10:14:20 INFO - PROCESS | 15853 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.40 Median:177.00 stddev:2.27 (1.3%) stddev-sans-first:2.40 10:14:20 INFO - PROCESS | 15853 | Values: 177.0 176.0 174.0 178.0 175.0 178.0 181.0 174.0 177.0 174.0 10:14:20 INFO - PROCESS | 15853 | 10:14:20 INFO - PROCESS | 15853 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:70.00 stddev:2.10 (3.0%) stddev-sans-first:2.18 10:14:20 INFO - PROCESS | 15853 | Values: 69.0 68.0 73.0 73.0 69.0 69.0 69.0 73.0 68.0 71.0 10:14:20 INFO - PROCESS | 15853 | -------- Summary: end -------- 10:14:20 INFO - PROCESS | 15853 | 10:14:21 INFO - TEST-INFO | 15853: exit 0 10:14:21 INFO - TEST-OK | kraken | took 65125ms 10:14:21 INFO - SUITE-END | took 1186s 10:14:21 INFO - Completed test suite (00:19:47) 10:14:21 INFO - javascript benchmark 10:14:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2539.9619005714912, 2559.7440255974416, 2588.9223323300307, 2592.987035064825, 2609.2041927212194, 4543.4547854257535, 4598.770061496924, 4619.168549661068, 4671.135839869627, 4732.2428411454175, 4589.128065667521, 4596.103759766846, 4628.236341003739, 4635.860924172281, 4708.74101924394, 4280.828766849322, 4299.978500107511, 4302.0, 4310.719803212781, 4429.11417716458, 4371.27873900806, 4374.475062992446, 4377.080813029268, 4381.561843815625, 4401.691881568291, 4250.04374015847, 4280.807363668642, 4287.035417031143, 4312.54718254585, 4374.475062992429, 4273.337632666941, 4311.223979683656, 4324.286492728696, 4333.631641310492, 4341.088371442001, 4196.979015104936, 4204.348326009474, 4230.725002874803, 4267.8079486423185, 4329.393884856091, 4609.147307748078, 4618.699784513996, 4635.397398338195, 4645.46577143626, 4702.083093796711, 4851.393575803025, 4860.781264843055, 4873.756312184412, 4888.804447822083, 4966.255061740731, 4923.606111511071, 4926.507349265081, 4938.432080310774, 4944.777485013183, 4974.527419895104, 4578.175928332866, 4584.922543202345, 4610.377599024156, 4612.86161415158, 4616.792244349012, 4948.233023881304, 4983.25251212321, 5017.498250174954, 5087.87280317995, 5101.846944591668, 4896.608271338285, 4911.705297682151, 4913.361263035782, 4915.0415668944925, 4964.578010869044, 5000.424951130666, 5001.424836143818, 5009.273655319958, 5009.849704508871, 5028.270900719375, 4816.783244753994, 4887.36464259644, 4933.963867587775, 4943.901121977612, 5026.220935754964, 4933.58064564516, 4941.629377796679, 4944.184209605447, 4944.431390390079, 4992.825251116266, 4165.520965088993, 4167.5832416758085, 4171.812268447927, 4210.6841986850495, 4222.619964203175, 3628.528291322164, 3634.164142247245, 3644.3804553226014, 3653.8538458461894, 3663.413853783382, 4334.436523251957, 4354.150940566559, 4398.186335527937, 4410.933835992462, 4411.889702757392, 5003.074431230234, 5003.724795136302, 5006.249062640633, 5014.373203349582, 5060.468650791688, 4272.038791271939, 4279.40088387626, 4299.763513006752, 4335.34969754533, 4341.848035318749, 4415.779211039435, 4416.514183439819, 4431.490378606437, 4481.036577135931, 4482.8655140345845, 4706.1999460091865, 4708.764561771966, 4713.717176969393, 4714.693544919569, 4777.4267087949665, 4857.587105096107, 5002.924956125734, 5012.172991456368, 5017.448080711192, 5057.115004874206, 4728.645351598712, 4782.426108866958, 4799.256115302133, 4827.08285425768, 4834.250691142878, 4986.6509344347, 4992.026554821775, 4992.400911890596, 4993.975030124826, 5039.974800125976, 5033.320501732219, 5044.041632089891, 5049.823256186016, 5052.216906379517, 5101.336826212569, 4727.0, 4773.546513081252, 4786.904261914672, 4814.662973591815, 4900.191468407673, 4814.325994360863, 4820.060088282891, 4820.325154478446, 4820.855374338776, 4880.072786170616, 4748.976255118702, 4762.166620841408, 4772.737499437564, 4787.2101103318955, 4833.323334733211, 4801.303810947463, 4827.493113223061, 4859.781309841136, 4865.927011094907, 4958.107540642719, 4761.833335833229, 4783.880402989953, 4784.880377990439, 4795.304680821331, 4847.3698419206685], "value": 4572.774609633762, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.7498638119656, 568.2527476368573, 577.615885436185, 577.9219805326279, 583.4894467341077, 27721.445571088567, 38899.41650875236, 40079.599204008024, 40103.79948100263, 43353.13293734124, 39734.0, 40175.79912100443, 40201.39697904534, 40227.39658905112, 40276.19447611053, 7597.810054748634, 7746.38028957682, 7757.689692412297, 7770.9222907771045, 7798.610069496503, 7362.484626076177, 9684.806303873918, 9914.950425247864, 9929.156021738161, 10208.64269750559, 10010.649627263047, 10088.69733907984, 10093.192544596452, 10098.798024039515, 10170.898291017105, 9904.554295056703, 10001.09990100887, 10010.749731256705, 10015.098641122335, 10015.69952901414, 9814.558344874498, 9863.950680246624, 9869.407835529819, 9881.456519891402, 9927.950360248153, 38120.80939595312, 38456.23087538234, 38515.22969540622, 38540.614593853985, 38562.61437385618, 2872.770178385724, 3025.9243518911985, 3037.164779685582, 3047.8476076196325, 3117.0, 29007.70992290071, 29021.854890725623, 29345.706542934724, 29378.55932161019, 29390.0, 3264.820434876081, 3326.600807903043, 3355.0438125134465, 3366.1416338833687, 3429.742769292288, 247949.0, 248061.0, 248294.0, 248492.0, 250763.0, 30816.383672326876, 51738.0, 51815.74092129515, 51872.22191667128, 51917.0, 31714.84142579272, 33464.832675836464, 33475.66524334774, 33578.496322555184, 33588.49617255743, 13132.803007954888, 13230.801537976939, 13267.734645307233, 13272.933635331954, 13275.601731948056, 9930.354526955725, 10619.575216991389, 10701.83947240792, 10728.678139655824, 10738.838917416246, 7756.573388463576, 7791.337736292366, 7853.685852565947, 7864.764057078297, 7903.762887113396, 3012.51799712045, 3043.345680678665, 3056.66376698563, 3070.2324418895278, 3117.719405253538, 814.9307308878812, 827.6482494939747, 855.3969451536652, 878.7715194049465, 953.909378609031, 26541.469170616867, 28256.29359266035, 28623.427531449255, 28833.56749648757, 29058.0, 942.4157022645867, 973.8101070291225, 985.8619793228954, 987.0573602209872, 1015.2081376526321, 15128.773068403983, 15138.736277333932, 15196.772048419283, 15208.0, 15426.84573154254, 123660.0, 123823.0, 123980.0, 124556.0, 125108.37445812713, 48846.26730599044, 49415.752921235886, 49487.25769113466, 49517.752411237714, 49566.50433495619, 1091.9672409827876, 1167.9124065694937, 1188.3107797477442, 1197.9880201197877, 1209.4920133543933, 25318.0, 29221.85389073041, 29277.707222927496, 29286.0, 29348.706512934597, 40715.38926916158, 41415.0, 41425.79287103545, 41441.1711765769, 41500.37749433701, 294773.0, 295353.0, 296856.0, 298484.0, 298943.0, 22597.0, 24149.517009659357, 24745.62881556742, 25956.740432595434, 25963.740362596887, 37386.86145954967, 41839.0, 41991.0, 42246.78876605597, 42685.78657106694, 35147.12132196613, 35192.12019699528, 35283.470747938285, 35334.46998295079, 35928.64071359253, 34971.65028349684, 35463.645363546035, 35599.46600800938, 36307.00934345909, 36694.44958325574, 34555.481667774504, 34666.306673865874, 35575.11062223465, 35824.8208758965, 36026.63973360233, 29930.401391972475, 32261.354772903942, 32552.34895302128, 32707.509387359685, 32766.67233327636, 24375.51248975046, 24443.877780610983, 24847.0, 25127.623085654097, 25383.61924571096], "value": 16154.692801994479, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.8011833550715, 368.85983326336, 376.74946160803074, 377.0893292698134, 387.27386150966936, 15842.128682922435, 16766.497005089837, 16964.236609352578, 17049.0, 17092.82907170928, 16576.585585360343, 17027.40404085857, 17477.300907963665, 17590.912045439756, 17602.735958960628, 5006.274090256919, 5250.7112108834, 5250.947490525104, 5254.7635356409055, 5255.159174532076, 3667.7065834733157, 3866.7679939203736, 5079.1365467870555, 5851.327097383792, 6082.9391706082815, 6156.445919867211, 6164.445199932005, 6169.0, 6173.135760993465, 6174.444300012998, 5926.970365148169, 6114.602550834204, 6122.387761223887, 6130.509559235251, 6131.601445906002, 5133.640645154841, 5269.0252303324005, 5370.221317908881, 5376.086065368897, 5376.40859505458, 20385.18459261628, 20952.266670666453, 20990.5801883963, 21229.68155477669, 21234.8147777833, 1872.691005984011, 2200.0, 2309.364924645719, 2409.33743220614, 2491.700995880488, 13164.341782910911, 13315.134516256412, 13396.0, 13454.327283635877, 13964.231967241798, 1777.3512667876262, 1789.4363275568155, 1816.5095424235383, 1836.9540761481069, 1942.5920556683113, 63376.0, 68742.65628671875, 68792.65603672, 69527.0, 69924.30075699229, 9672.903270967201, 9969.40183588987, 10028.548715307828, 10054.0, 10158.917421928487, 13556.59330220095, 13562.93218533901, 13568.118072325464, 13584.0, 13588.796168057486, 7014.508984371147, 7183.42532597391, 7322.597257150801, 7403.85192296151, 7431.516951398142, 6835.897461538081, 6998.825029374307, 7174.641267936582, 7177.4258059355125, 7450.590217538087, 4157.376393540993, 4198.895027624334, 4243.766592837362, 4358.4769827620885, 4401.207782599099, 1662.709025920459, 1698.9915050424668, 1752.8422441980283, 1791.802901680814, 1799.262302456013, 796.2077732656045, 804.1194891593696, 841.2891107014563, 863.9654413823376, 936.7798567336671, 16179.271932763055, 16639.334426622798, 16744.079075650956, 16799.32802687879, 17808.732869006973, 818.1123481023157, 844.6536919862949, 871.172386233081, 877.9165979231963, 883.8453270677605, 9161.0, 9797.755056123653, 9846.0, 9874.50627468638, 9933.701988940198, 379516.0, 381040.0, 426413.0, 429089.0, 433762.0, 79397.0, 81279.18720812716, 83098.58450707707, 83633.16366836254, 85798.0, 865.7272959017889, 912.2975309012156, 935.0509233128245, 935.8081593273363, 936.9906300936904, 11679.591214307458, 14704.485343012942, 15538.766918496458, 16263.186840657683, 16499.422520211734, 39446.40830387604, 39721.60278397179, 40121.79939100286, 40500.39249411202, 41238.79380603078, 48540.5145948536, 49493.29976974879, 51346.22980655368, 51373.48626513687, 51448.0, 6925.238223795479, 7087.255838137127, 7134.250903655042, 7254.89117663246, 7335.376492997942, 7989.760307190793, 8089.069756977788, 10631.096356809758, 11959.820602690792, 12122.27266364021, 9965.202783777135, 9998.200143988319, 10248.180145588483, 10494.947525262325, 10748.408837514013, 10126.341787783771, 10144.847827282449, 10244.180465562886, 10358.326708763907, 10728.302660327054, 9963.850542242017, 10242.334248273839, 10320.27758056959, 10724.839127412939, 11075.889241107487, 7356.117265928123, 7670.890505110916, 7671.462997590115, 7829.804254893673, 7866.685332586632, 9748.951255243679, 10262.0, 10273.075423211947, 10274.33216840903, 10556.577736890438], "value": 8367.53877692193, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1338.1903948111396, 1373.025152141979, 1408.8238970128734, 1613.3465946291756, 1625.4554724167403, 6663.100481435004, 6848.486363522731, 6989.266127056662, 7477.14012888518, 7492.662830172641, 7209.423246140309, 7476.551406915589, 7485.625718714056, 7686.154523002465, 7687.807804804883, 2110.008296100834, 2134.7331583552054, 2134.9039293231763, 2137.625915464795, 2141.2184552638255, 1828.552004758836, 2050.784667609902, 2051.805078517546, 2087.0712532922857, 2131.6163090643677, 2055.691646253059, 2106.29439137889, 2107.3361891004283, 2107.399391173516, 2109.5253567947243, 2047.1402011155276, 2052.3842847145797, 2054.5479994401207, 2056.0850421562263, 2085.7705652378227, 2080.4798800299927, 2083.4583008417767, 2083.6874468829647, 2084.270505323125, 2092.0272073485903, 7616.771496855104, 7827.452078354518, 7834.1382447931255, 7835.333996610295, 7835.333996610295, 4269.7224680395675, 4311.525732169459, 4322.222000039991, 4438.933415998763, 4446.377507149002, 2756.7105453927247, 2832.6884042755282, 2889.971100289012, 2891.1471116020825, 2897.463969165711, 911.1662828511903, 913.6117150211134, 926.8543322209132, 930.4928813796497, 931.3899395895631, 10258.79482410355, 10263.79472410555, 10264.589416423334, 10274.178065754722, 10289.588416463332, 3729.5710993235584, 3829.1193025604266, 3988.282109220368, 3990.700697447703, 4033.9394909076386, 8665.17680820321, 8666.220040196413, 8671.869921951049, 8676.262517685942, 8676.436031657922, 4444.511103778582, 4448.266036104072, 4456.710313829655, 4456.955430445719, 4459.44256967879, 4008.2785098682516, 4070.4504891839815, 4075.286824805647, 4075.7962101895378, 4077.571854955246, 3511.94732079019, 3540.362734707726, 3565.3938830398893, 3607.8917632471066, 3630.074331045619, 1026.7381817636604, 1104.5636973395465, 1139.5214010115772, 1140.6977151054812, 1143.5025763792776, 770.6339488742802, 790.9169537198511, 817.627979269431, 825.8224481736336, 859.7592674051276, 4970.801167953241, 5031.924521132186, 5114.693118412907, 5116.74416279192, 5343.65266257692, 837.2883049407955, 853.1468531468531, 879.6305551668314, 888.5424006636588, 910.0899100899101, 3461.4980827780337, 3532.1875968527384, 3587.8744243951337, 3609.151849315409, 3694.7413681042067, 8768.640860666606, 9062.728118156467, 9098.454092754457, 9467.242620590336, 9468.14786669203, 9321.906780932239, 9331.020242874536, 9334.25325973934, 9344.95327523358, 9347.766305842408, 6953.6523173842115, 6974.4420446364165, 7130.322619351154, 7161.104861892263, 7197.4961752677855, 5389.461053894579, 5408.161734931092, 5425.674459532441, 5466.371367292653, 5695.857603559944, 8708.738737837875, 8724.389292749447, 8807.779805504657, 8821.823563528822, 8831.116888311117, 8287.58562071906, 8629.39594228398, 8643.394962352575, 8661.090585488684, 8940.15068568485, 6150.969245153925, 6260.467860231931, 6266.968665156645, 6289.811305660837, 6296.150019747275, 7207.387372073433, 7276.272372762682, 7277.708891644275, 7285.526440781332, 7286.890696639449, 6014.36849130835, 6025.87948241024, 6123.112148738497, 6147.44672979434, 6201.255849298113, 6544.411003009752, 6578.506612004215, 6607.07500949877, 6610.07458955737, 6655.900161497679, 5945.375735547878, 6051.697415129138, 6052.75788968454, 6053.515718742578, 6060.363661815446, 4290.099079193279, 4355.368471571541, 4378.146261478981, 4477.261251893401, 4519.909601808011, 4434.623057040188, 4578.381918440968, 4587.2201725706045, 4692.906141877212, 4728.527147285244], "value": 4006.7687141974448, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.06775648533477, 298.8759664739133, 302.63834717512583, 308.551058210304, 309.25315363397397, 4835.153848076586, 4900.852974410765, 4909.386326709166, 4915.311856340115, 4930.225118957177, 4804.351412559304, 4826.662133650646, 4845.4427740809815, 4860.781264843082, 4879.657764273142, 3604.6215147409603, 3718.3678774608384, 3740.214554943465, 3807.9147442978756, 3841.9039524011846, 3810.8856734298015, 3822.44574536692, 3828.502294701685, 3837.808109594509, 3861.4787003754413, 3775.2449510097954, 3781.2626537825136, 3793.1275806564367, 3798.22136462026, 3807.276617442691, 3611.747177697562, 3677.5035370225078, 3761.1349389640263, 3808.2383523295175, 3817.141143242748, 3377.392069427502, 3380.647740903634, 3381.780184288038, 3389.6271410144864, 3398.3882901077795, 4676.181668208084, 4692.601128904047, 4702.835400760957, 4703.576678098988, 4704.411948506437, 4214.0, 4307.956920430787, 4326.740395576244, 4338.43600331958, 4347.7173983690955, 4964.6276529260085, 4977.352944117241, 4987.5760560352055, 4988.900221995576, 4998.200287953946, 3652.3425783358985, 3655.9580519552064, 3658.5975542690285, 3661.1945372018113, 3663.6336366363416, 5091.766728127665, 5252.343457067866, 5271.130263506517, 5279.41926388097, 5286.127788914824, 3746.4380342948775, 3756.549214094326, 3760.8495660173285, 3767.1900541383184, 3785.6403641653997, 3804.622111180512, 3812.4471951566866, 3818.885433437001, 3830.9042273943373, 3833.4058220975235, 4313.654907607384, 4321.286987647066, 4323.589259020388, 4337.522872484024, 4351.73889566627, 4836.250381190921, 4962.6774259673, 4970.676906001098, 4975.4278258000795, 5047.899042019139, 1304.0, 1322.93385330735, 1323.384626148826, 1330.6872884872048, 1331.9943442700699, 851.535912927456, 852.3394369363668, 856.8389831777976, 860.2558786649503, 871.7864123289835, 4305.5048669402795, 4368.143538995914, 4377.518472967971, 4398.956010439919, 4460.464744230713, 5127.307813445137, 5139.743012849417, 5173.051360724427, 5188.351456067991, 5211.530962213419, 4398.582134697199, 4494.5505449454795, 4500.549945005473, 4514.367988481616, 4539.296409056601, 2738.1374866917254, 2747.8763455644544, 2753.1740477856565, 2757.2141939547532, 2773.2234974207254, 4879.658423910292, 4880.0, 4916.0905232532095, 4917.532834380728, 4925.162722337212, 5020.5732512736095, 5233.319668443078, 5269.420363759983, 5298.947010529922, 5318.627696061239, 4900.289458028566, 4908.582770464479, 4919.237518184687, 4945.109880221451, 4946.727929963887, 5222.164453687392, 5226.764795584132, 5228.843134705965, 5236.214567814706, 5240.737963101754, 4952.059108769322, 5047.0, 5094.7962081516325, 5097.088591778083, 5115.335006449138, 4853.247746599282, 4878.9512104878495, 4892.217245240744, 4900.77014958186, 4912.901741965069, 3746.6815320698047, 3753.455748916337, 3764.6235376462137, 3783.791891445997, 3787.8295476704166, 5020.824271150492, 5186.533212010786, 5241.68549887008, 5243.161094224905, 5246.895062098813, 5032.974835125948, 5047.899042019212, 5054.721990290569, 5068.873278168076, 5076.593872490266, 5017.774200160929, 5077.390713114302, 5088.0078384714625, 5088.099783123584, 5092.592592592658, 4810.5670489656095, 4907.33750943618, 4947.752612369439, 4950.203135228584, 5033.169527028, 4783.330333753208, 4878.707277563358, 5033.572146367454, 5053.823116190915, 5068.518490743373, 4909.091818013679, 4918.729469879191, 4944.381952255968, 4966.230234313687, 4975.776090076028], "value": 3823.0593954219653, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.4421643654965, 597.423486335686, 616.7471336751933, 695.3220609905342, 697.9825504362391, 12687.175333603309, 13931.37308821103, 13948.442062317508, 13949.093308934913, 13965.581032569014, 13295.800562991562, 13374.66563335917, 13429.0, 13476.3261836908, 13489.46042158315, 608.6135304081896, 621.8880601491752, 728.3481284250593, 738.6786747764726, 759.5215014540831, 752.9811754706121, 768.2509553185655, 769.6459628570836, 769.8113962079299, 770.3721467004374, 800.6957356204634, 807.6728924785442, 807.7576726981882, 808.2119933065273, 808.3210103513048, 648.2739331948248, 780.1808101493409, 797.2306724011299, 809.4333966223637, 809.9433039687224, 587.7825204674255, 588.2852334413708, 588.6615196262167, 589.666838236395, 590.400743245606, 12069.155159138863, 12086.33525156116, 12099.274043557327, 12108.515659373614, 12113.39433028345, 12262.325572093532, 12488.375581220902, 12855.421506032251, 13194.208347499181, 13300.002499812554, 11772.587959421464, 11801.878821511942, 11909.702257443547, 12153.939230303791, 12246.571370002097, 3231.0952933178746, 3369.1913940654313, 4065.715399922007, 4096.221717873625, 4181.770002649853, 62065.0, 62233.688831555555, 62259.68870155665, 63099.36900630981, 63431.0, 9889.554970026365, 10063.245256605784, 10156.898431015743, 10176.796464070678, 10181.236407269484, 17785.644287114443, 17809.910950445166, 17810.821891780917, 17818.19818108162, 17829.7325540117, 6566.5403421760975, 6689.899651505231, 6695.363940425652, 6947.79156625302, 6968.233494315621, 3708.7686669219343, 3776.3957766757185, 3817.9809100954317, 3836.5971572984995, 3872.0, 2864.7135286471603, 2976.37496125816, 2998.770504093311, 3001.8949336773107, 3009.8043627164166, 506.48338694532106, 518.1709265175764, 520.9036328279204, 526.3131613244676, 534.7513406266105, 500.624531601299, 531.981380651683, 537.3605409562608, 557.0585710149834, 563.7096895099028, 7314.268573142643, 7883.921160788434, 7936.23185524946, 8127.309178719756, 8333.33333333332, 492.7979528393413, 536.1421725239663, 555.1478480532363, 558.9720513974366, 562.4235158962097, 3724.5902950675404, 3786.848526058982, 3796.544414670202, 3822.6177382261553, 3853.9887139591137, 98135.50932245293, 98845.0, 101371.0, 101395.0, 104528.47735761425, 51075.48924510782, 52022.0, 52415.0, 52438.47561524412, 75607.24392756113, 48841.51158488441, 52147.73926130345, 60337.39662603405, 73154.17114572179, 76058.23941760622, 6950.965245173742, 7111.857762844817, 7345.155307139534, 7371.262873712586, 7374.483786134919, 43803.0, 46147.0, 47062.05875882532, 47072.05855882795, 47212.527874720814, 39557.0, 41332.0, 62642.37357626366, 65666.0, 66750.0, 10018.799624007333, 10108.090271875566, 10452.425116618659, 10849.783004340026, 11306.434678265889, 12047.638570842888, 12540.372981350714, 12632.873671263169, 12827.294498802656, 13463.596092117252, 11093.889061109285, 11739.647810565697, 11809.984605234262, 12001.519939202333, 12141.15011949155, 11141.832872506757, 11309.20835541537, 11499.137564682514, 11717.414129293671, 11852.822207667065, 11608.709782255512, 11638.767224655629, 11697.941510292394, 12304.200226985216, 12316.199447035913, 9437.764055898657, 9547.856782148134, 9584.37701549397, 9788.0, 10179.49102544855, 9248.768780780534, 9679.274054445805, 9694.175995040501, 9964.900350996397, 10002.549885255326], "value": 6362.075517844989, "unit": "score"}], "name": "dromaeo_css", "value": 6261.15850375683, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 129.0, 115.0, 114.0, 114.0, 112.0, 114.0, 115.0, 115.0], "value": 115.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 126.0, 146.0, 193.0, 121.0, 158.0, 152.0, 124.0, 193.0, 127.0], "value": 148.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 161.0, 162.0, 162.0, 162.0, 163.0, 162.0, 164.0, 160.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 159.0, 76.0, 76.0, 75.0, 77.0, 172.0, 75.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 150.0, 89.0, 88.0, 88.0, 144.0, 86.0, 87.0, 137.0], "value": 104.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 118.0, 118.0, 118.0, 119.0, 118.0, 118.0, 117.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 95.0, 94.0, 95.0, 96.0, 94.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 69.0, 68.0, 68.0, 70.0, 68.0, 67.0, 66.0, 69.0], "value": 68.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 64.0, 66.0, 65.0, 64.0, 66.0, 65.0, 66.0, 66.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 89.0, 91.0, 82.0, 89.0, 81.0, 81.0, 82.0, 82.0, 82.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 133.0, 140.0, 131.0, 135.0, 138.0, 131.0, 133.0, 146.0, 130.0], "value": 134.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 176.0, 174.0, 178.0, 175.0, 178.0, 181.0, 174.0, 177.0, 174.0], "value": 176.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 73.0, 73.0, 69.0, 69.0, 69.0, 73.0, 68.0, 71.0], "value": 70.2, "unit": "score"}], "name": "kraken", "value": 1582.4000000000005, "alertThreshold": 2.0}]} 10:14:22 INFO - Return code: 0 10:14:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:14:22 INFO - # TBPL SUCCESS # 10:14:22 INFO - Running post-action listener: _resource_record_post_action 10:14:22 INFO - [mozharness: 2016-08-23 17:14:22.109881Z] Finished run-tests step (success) 10:14:22 INFO - Running post-run listener: _resource_record_post_run 10:14:22 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 413802496; Read time: 16; Write time: 277968 10:14:22 INFO - TinderboxPrint: CPU usage
13.2% 10:14:22 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 10:14:22 INFO - TinderboxPrint: I/O write bytes / time
413,802,496 / 277,968 10:14:22 INFO - TinderboxPrint: CPU idle
8,326.3 (86.7%) 10:14:22 INFO - TinderboxPrint: CPU user
1,207.2 (12.6%) 10:14:22 INFO - TinderboxPrint: Swap in / out
0 / 0 10:14:22 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 122482688; Read time: 0; Write time: 92508 10:14:22 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 291319808; Read time: 0; Write time: 185460 10:14:22 INFO - Running post-run listener: _upload_blobber_files 10:14:22 INFO - Blob upload gear active. 10:14:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:14:22 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 10:14:22 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'] 10:14:22 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 10:14:23 INFO - (blobuploader) - INFO - Open directory for files ... 10:14:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:14:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:14:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:14:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:14:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:14:23 INFO - (blobuploader) - INFO - Done attempting. 10:14:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:14:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:14:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:14:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:14:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:14:28 INFO - (blobuploader) - INFO - Done attempting. 10:14:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:14:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:14:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:14:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:14:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:14:29 INFO - (blobuploader) - INFO - Done attempting. 10:14:29 INFO - (blobuploader) - INFO - Iteration through files over. 10:14:29 INFO - Return code: 0 10:14:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:14:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:14:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a29acd5a3422a3faddae16e24b06c05a44c034c040f97458a7be347034d7200d3f932c471a4dd8108d3d900f24be8d7940505f508fc270d1b588a31662f82d28", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9b383e3eb91c111ac99707fabdac0378cde646d7e944568f3d6b19473b0a88e1d2df33d4e6d1643ede4303c97b8cb3b0a11abed5bacba2228e0d2b9dd001714e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/71900b237d581228f160d232c82a941317aac0f2c6c1dac83d674c3917b026cc371e2bd248fcff75bad5ee958ed1e21838a737c2c36ef64ac6eb02dcc82a608f"} 10:14:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:14:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:14:29 INFO - Contents: 10:14:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a29acd5a3422a3faddae16e24b06c05a44c034c040f97458a7be347034d7200d3f932c471a4dd8108d3d900f24be8d7940505f508fc270d1b588a31662f82d28", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9b383e3eb91c111ac99707fabdac0378cde646d7e944568f3d6b19473b0a88e1d2df33d4e6d1643ede4303c97b8cb3b0a11abed5bacba2228e0d2b9dd001714e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/71900b237d581228f160d232c82a941317aac0f2c6c1dac83d674c3917b026cc371e2bd248fcff75bad5ee958ed1e21838a737c2c36ef64ac6eb02dcc82a608f"} 10:14:29 INFO - Running post-run listener: copy_logs_to_upload_dir 10:14:29 INFO - Copying logs to upload dir... 10:14:29 INFO - mkdir: /builds/slave/test/build/upload/logs 10:14:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.471853 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-08-23 10:14:29.196012) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-23 10:14:29.199026) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1471971216.845022-1881525037 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/a29acd5a3422a3faddae16e24b06c05a44c034c040f97458a7be347034d7200d3f932c471a4dd8108d3d900f24be8d7940505f508fc270d1b588a31662f82d28", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9b383e3eb91c111ac99707fabdac0378cde646d7e944568f3d6b19473b0a88e1d2df33d4e6d1643ede4303c97b8cb3b0a11abed5bacba2228e0d2b9dd001714e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/71900b237d581228f160d232c82a941317aac0f2c6c1dac83d674c3917b026cc371e2bd248fcff75bad5ee958ed1e21838a737c2c36ef64ac6eb02dcc82a608f"} build_url:https://queue.taskcluster.net/v1/task/TtWoa8L8TjOWiu-gs17hsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011182 build_url: 'https://queue.taskcluster.net/v1/task/TtWoa8L8TjOWiu-gs17hsg/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/a29acd5a3422a3faddae16e24b06c05a44c034c040f97458a7be347034d7200d3f932c471a4dd8108d3d900f24be8d7940505f508fc270d1b588a31662f82d28", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9b383e3eb91c111ac99707fabdac0378cde646d7e944568f3d6b19473b0a88e1d2df33d4e6d1643ede4303c97b8cb3b0a11abed5bacba2228e0d2b9dd001714e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/71900b237d581228f160d232c82a941317aac0f2c6c1dac83d674c3917b026cc371e2bd248fcff75bad5ee958ed1e21838a737c2c36ef64ac6eb02dcc82a608f"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-23 10:14:29.254690) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 10:14:29.255018) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1471971216.845022-1881525037 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004628 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 10:14:29.304295) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-23 10:14:29.304623) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-23 10:14:29.325506) ========= ========= Total master_lag: 0.19 =========