builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-006 starttime: 1472571994.42 results: success (0) buildid: 20160830065621 builduid: a730868a64b54429a50884c6ee4274ec revision: b18c8bcdc116eef8799880b7c50317bf54218474 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 08:46:34.416879) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 08:46:34.418454) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 08:46:34.418733) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 08:46:34.433614) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 08:46:34.434192) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1472571993.445385-1117785531 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-30 08:46:34-- 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% 82.9M=0s 2016-08-30 08:46:34 (82.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101079 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 08:46:34.549417) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 08:46:34.549957) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1472571993.445385-1117785531 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017195 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 08:46:34.601184) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-30 08:46:34.601555) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b18c8bcdc116eef8799880b7c50317bf54218474 --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 b18c8bcdc116eef8799880b7c50317bf54218474 --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=e31afd3c0f0de4e86ebe4d94000001b5-1472571993.445385-1117785531 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-30 08:46:34,879 truncating revision to first 12 chars 2016-08-30 08:46:34,879 Setting DEBUG logging. 2016-08-30 08:46:34,879 attempt 1/10 2016-08-30 08:46:34,879 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b18c8bcdc116?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-30 08:46:36,095 unpacking tar archive at: fx-team-b18c8bcdc116/testing/mozharness/ program finished with exit code 0 elapsedTime=1.522411 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-30 08:46:36.166271) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 08:46:36.166619) ========= script_repo_revision: b18c8bcdc116eef8799880b7c50317bf54218474 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 08:46:36.170259) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 08:46:36.170593) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 08:46:36.182641) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-08-30 08:46:36.183269) ========= /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=e31afd3c0f0de4e86ebe4d94000001b5-1472571993.445385-1117785531 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:46:36 INFO - MultiFileLogger online at 20160830 08:46:36 in /builds/slave/test 08:46:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 08:46:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:46:36 INFO - {'append_to_log': False, 08:46:36 INFO - 'base_work_dir': '/builds/slave/test', 08:46:36 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:46:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:46:36 INFO - 'branch': 'Fx-Team-Non-PGO', 08:46:36 INFO - 'buildbot_json_path': 'buildprops.json', 08:46:36 INFO - 'config_files': ('talos/linux_config.py',), 08:46:36 INFO - 'default_actions': ('clobber', 08:46:36 INFO - 'read-buildbot-config', 08:46:36 INFO - 'download-and-extract', 08:46:36 INFO - 'populate-webroot', 08:46:36 INFO - 'create-virtualenv', 08:46:36 INFO - 'install', 08:46:36 INFO - 'run-tests'), 08:46:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:46:36 INFO - 'download_minidump_stackwalk': True, 08:46:36 INFO - 'download_symbols': 'ondemand', 08:46:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:46:36 INFO - 'tooltool.py': '/tools/tooltool.py', 08:46:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:46:36 INFO - '/tools/misc-python/virtualenv.py')}, 08:46:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:46:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:46:36 INFO - 'installer_path': 'installer.exe', 08:46:36 INFO - 'log_level': 'info', 08:46:36 INFO - 'log_name': 'talos', 08:46:36 INFO - 'log_to_console': True, 08:46:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:46:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:46:36 INFO - 'opt_config_files': (), 08:46:36 INFO - 'pip_index': False, 08:46:36 INFO - 'sps_profile': False, 08:46:36 INFO - 'sps_profile_interval': 0, 08:46:36 INFO - 'suite': 'dromaeojs', 08:46:36 INFO - 'system_bits': '32', 08:46:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:46:36 INFO - 'title': 'talos-linux64-ix-006', 08:46:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:46:36 INFO - 'use_talos_json': True, 08:46:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:46:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:46:36 INFO - 'work_dir': 'build'} 08:46:36 INFO - [mozharness: 2016-08-30 15:46:36.559712Z] Running clobber step. 08:46:36 INFO - Running pre-action listener: _resource_record_pre_action 08:46:36 INFO - Running main action method: clobber 08:46:36 INFO - rmtree: /builds/slave/test/build 08:46:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:46:37 INFO - Running post-action listener: _resource_record_post_action 08:46:37 INFO - [mozharness: 2016-08-30 15:46:37.537121Z] Finished clobber step (success) 08:46:37 INFO - [mozharness: 2016-08-30 15:46:37.537222Z] Running read-buildbot-config step. 08:46:37 INFO - Running pre-action listener: _resource_record_pre_action 08:46:37 INFO - Running main action method: read_buildbot_config 08:46:37 INFO - Using buildbot properties: 08:46:37 INFO - { 08:46:37 INFO - "project": "", 08:46:37 INFO - "product": "firefox", 08:46:37 INFO - "script_repo_revision": "production", 08:46:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:46:37 INFO - "repository": "", 08:46:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 08:46:37 INFO - "buildid": "20160830065621", 08:46:37 INFO - "pgo_build": "False", 08:46:37 INFO - "basedir": "/builds/slave/test", 08:46:37 INFO - "buildnumber": 1904, 08:46:37 INFO - "slavename": "talos-linux64-ix-006", 08:46:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:46:37 INFO - "platform": "ubuntu64_hw", 08:46:37 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:46:37 INFO - "branch": "fx-team", 08:46:37 INFO - "repo_path": "integration/fx-team", 08:46:37 INFO - "revision": "b18c8bcdc116eef8799880b7c50317bf54218474", 08:46:37 INFO - "stage_platform": "linux64", 08:46:37 INFO - "builduid": "a730868a64b54429a50884c6ee4274ec", 08:46:37 INFO - "slavebuilddir": "test" 08:46:37 INFO - } 08:46:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/XBOddpQWTCSS6QyaUAm_rw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 08:46:37 INFO - Running post-action listener: _resource_record_post_action 08:46:37 INFO - [mozharness: 2016-08-30 15:46:37.539664Z] Finished read-buildbot-config step (success) 08:46:37 INFO - [mozharness: 2016-08-30 15:46:37.539754Z] Running download-and-extract step. 08:46:37 INFO - Running pre-action listener: _resource_record_pre_action 08:46:37 INFO - Running main action method: download_and_extract 08:46:37 INFO - mkdir: /builds/slave/test/build/tests 08:46:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:37 INFO - trying https://queue.taskcluster.net/v1/task/XBOddpQWTCSS6QyaUAm_rw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:46:37 INFO - Downloading https://queue.taskcluster.net/v1/task/XBOddpQWTCSS6QyaUAm_rw/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 08:46:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XBOddpQWTCSS6QyaUAm_rw/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 08:46:38 INFO - Downloaded 1361 bytes. 08:46:38 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:46:38 INFO - Using the following test package requirements: 08:46:38 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:46:38 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:38 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:46:38 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:38 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:46:38 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:38 INFO - u'jsshell-linux-x86_64.zip'], 08:46:38 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:38 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:46:38 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:46:38 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:38 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:46:38 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:38 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:46:38 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:38 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:46:38 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:38 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:46:38 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:46:38 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')]} 08:46:38 INFO - trying https://queue.taskcluster.net/v1/task/XBOddpQWTCSS6QyaUAm_rw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:46:38 INFO - Downloading https://queue.taskcluster.net/v1/task/XBOddpQWTCSS6QyaUAm_rw/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 08:46:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XBOddpQWTCSS6QyaUAm_rw/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 08:46:39 INFO - Downloaded 20315467 bytes. 08:46:39 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 08:46:43 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 08:46:43 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')]} 08:46:43 INFO - trying https://queue.taskcluster.net/v1/task/XBOddpQWTCSS6QyaUAm_rw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:46:43 INFO - Downloading https://queue.taskcluster.net/v1/task/XBOddpQWTCSS6QyaUAm_rw/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 08:46:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XBOddpQWTCSS6QyaUAm_rw/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 08:46:44 INFO - Downloaded 20315467 bytes. 08:46:44 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 08:46: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')]} 08:46:48 INFO - trying https://queue.taskcluster.net/v1/task/XBOddpQWTCSS6QyaUAm_rw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:46:48 INFO - Downloading https://queue.taskcluster.net/v1/task/XBOddpQWTCSS6QyaUAm_rw/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 08:46:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XBOddpQWTCSS6QyaUAm_rw/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 08:46:50 INFO - Downloaded 14413998 bytes. 08:46:50 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 08:46:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:50 INFO - trying https://queue.taskcluster.net/v1/task/XBOddpQWTCSS6QyaUAm_rw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:46:50 INFO - Downloading https://queue.taskcluster.net/v1/task/XBOddpQWTCSS6QyaUAm_rw/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 08:46:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XBOddpQWTCSS6QyaUAm_rw/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 08:46:52 INFO - Downloaded 55850750 bytes. 08:46:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XBOddpQWTCSS6QyaUAm_rw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:46:52 INFO - mkdir: /builds/slave/test/properties 08:46:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:46:52 INFO - Writing to file /builds/slave/test/properties/build_url 08:46:52 INFO - Contents: 08:46:52 INFO - build_url:https://queue.taskcluster.net/v1/task/XBOddpQWTCSS6QyaUAm_rw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:46:53 INFO - Running post-action listener: _resource_record_post_action 08:46:53 INFO - Running post-action listener: set_extra_try_arguments 08:46:53 INFO - [mozharness: 2016-08-30 15:46:53.438129Z] Finished download-and-extract step (success) 08:46:53 INFO - [mozharness: 2016-08-30 15:46:53.438356Z] Running populate-webroot step. 08:46:53 INFO - Running pre-action listener: _resource_record_pre_action 08:46:53 INFO - Running main action method: populate_webroot 08:46:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:46:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:46:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:46:53 INFO - '--tppagecycles', 08:46:53 INFO - '7'], 08:46:53 INFO - 'tests': ['tsvgm']}}, 08:46:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:46:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:46:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:46:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:46:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:46:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:46:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:53 INFO - 'talos_options': ['--disable-e10s'], 08:46:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:46:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:46:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:53 INFO - 'talos_options': ['--disable-e10s'], 08:46:53 INFO - 'tests': ['damp', 'tps']}, 08:46:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:53 INFO - 'tests': ['damp', 'tps']}, 08:46:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:46:53 INFO - 'tests': ['dromaeo_dom']}, 08:46:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:46:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:46:53 INFO - 'tests': ['basic_compositor_video']}, 08:46:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:46:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:46:53 INFO - 'tests': ['a11yr', 08:46:53 INFO - 'ts_paint', 08:46:53 INFO - 'tpaint', 08:46:53 INFO - 'sessionrestore', 08:46:53 INFO - 'sessionrestore_no_auto_restore', 08:46:53 INFO - 'tabpaint']}, 08:46:53 INFO - 'other-e10s': {'tests': ['a11yr', 08:46:53 INFO - 'ts_paint', 08:46:53 INFO - 'tpaint', 08:46:53 INFO - 'sessionrestore', 08:46:53 INFO - 'sessionrestore_no_auto_restore', 08:46:53 INFO - 'tabpaint']}, 08:46:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:46:53 INFO - 'ts_paint', 08:46:53 INFO - 'tpaint', 08:46:53 INFO - 'sessionrestore', 08:46:53 INFO - 'sessionrestore_no_auto_restore', 08:46:53 INFO - 'tabpaint']}, 08:46:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:46:53 INFO - 'ts_paint', 08:46:53 INFO - 'tpaint', 08:46:53 INFO - 'sessionrestore', 08:46:53 INFO - 'sessionrestore_no_auto_restore', 08:46:53 INFO - 'tabpaint']}, 08:46:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:46:53 INFO - 'tests': ['a11yr', 08:46:53 INFO - 'ts_paint', 08:46:53 INFO - 'tpaint', 08:46:53 INFO - 'sessionrestore', 08:46:53 INFO - 'sessionrestore_no_auto_restore', 08:46:53 INFO - 'tabpaint']}, 08:46:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:46:53 INFO - 'tests': ['a11yr', 08:46:53 INFO - 'ts_paint', 08:46:53 INFO - 'tpaint', 08:46:53 INFO - 'sessionrestore', 08:46:53 INFO - 'sessionrestore_no_auto_restore', 08:46:53 INFO - 'tabpaint']}, 08:46:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:46:53 INFO - 'tests': ['tsvgx', 08:46:53 INFO - 'tsvgr_opacity', 08:46:53 INFO - 'tart', 08:46:53 INFO - 'tscrollx', 08:46:53 INFO - 'cart']}, 08:46:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:46:53 INFO - 'tsvgr_opacity', 08:46:53 INFO - 'tart', 08:46:53 INFO - 'tscrollx', 08:46:53 INFO - 'cart']}, 08:46:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:53 INFO - 'talos_options': ['--disable-e10s'], 08:46:53 INFO - 'tests': ['tp5o']}, 08:46:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:53 INFO - 'tests': ['tp5o']}, 08:46:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:53 INFO - 'talos_options': ['--disable-e10s', 08:46:53 INFO - '--xperf_path', 08:46:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:46:53 INFO - 'tests': ['tp5n']}, 08:46:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:53 INFO - 'talos_options': ['--xperf_path', 08:46:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:46:53 INFO - 'tests': ['tp5n']}}, 08:46:53 INFO - 'talos.zip': {'path': '', 08:46:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:46:53 INFO - Running post-action listener: _resource_record_post_action 08:46:53 INFO - [mozharness: 2016-08-30 15:46:53.453563Z] Finished populate-webroot step (success) 08:46:53 INFO - [mozharness: 2016-08-30 15:46:53.453652Z] Running create-virtualenv step. 08:46:53 INFO - Running pre-action listener: _resource_record_pre_action 08:46:53 INFO - Running main action method: create_virtualenv 08:46:53 INFO - Creating virtualenv /builds/slave/test/build/venv 08:46:53 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:46:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:46:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:46:53 INFO - Using real prefix '/usr' 08:46:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:46:54 INFO - Installing distribute.............................................................................................................................................................................................done. 08:46:56 INFO - Installing pip.................done. 08:46:56 INFO - Return code: 0 08:46:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:46:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0e08dfff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1299090>, '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 0x129c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129ce40>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1472571993.445385-1117785531', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:46:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:46:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:46:56 INFO - Using env: {'DISPLAY': ':0', 08:46:56 INFO - 'HOME': '/home/cltbld', 08:46:56 INFO - 'LANG': 'en_US.UTF-8', 08:46:56 INFO - 'LANGUAGE': 'en_US:en', 08:46:56 INFO - 'LOGNAME': 'cltbld', 08:46:56 INFO - 'MAIL': '/var/mail/cltbld', 08:46:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:56 INFO - 'MOZ_NO_REMOTE': '1', 08:46:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:56 INFO - 'NO_EM_RESTART': '1', 08:46:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:56 INFO - 'PWD': '/builds/slave/test', 08:46:56 INFO - 'SHELL': '/bin/bash', 08:46:56 INFO - 'SHLVL': '1', 08:46:56 INFO - 'TERM': 'linux', 08:46:56 INFO - 'TMOUT': '86400', 08:46:56 INFO - 'USER': 'cltbld', 08:46:56 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1472571993.445385-1117785531', 08:46:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:56 INFO - '_': '/tools/buildbot/bin/python'} 08:46:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:46:56 INFO - Cleaning up... 08:46:56 INFO - Return code: 0 08:46:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:46:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0e08dfff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1299090>, '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 0x129c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129ce40>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1472571993.445385-1117785531', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:46:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:46:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:46:56 INFO - Using env: {'DISPLAY': ':0', 08:46:56 INFO - 'HOME': '/home/cltbld', 08:46:56 INFO - 'LANG': 'en_US.UTF-8', 08:46:56 INFO - 'LANGUAGE': 'en_US:en', 08:46:56 INFO - 'LOGNAME': 'cltbld', 08:46:56 INFO - 'MAIL': '/var/mail/cltbld', 08:46:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:56 INFO - 'MOZ_NO_REMOTE': '1', 08:46:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:56 INFO - 'NO_EM_RESTART': '1', 08:46:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:56 INFO - 'PWD': '/builds/slave/test', 08:46:56 INFO - 'SHELL': '/bin/bash', 08:46:56 INFO - 'SHLVL': '1', 08:46:56 INFO - 'TERM': 'linux', 08:46:56 INFO - 'TMOUT': '86400', 08:46:56 INFO - 'USER': 'cltbld', 08:46:56 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1472571993.445385-1117785531', 08:46:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:56 INFO - '_': '/tools/buildbot/bin/python'} 08:46:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:56 INFO - Downloading/unpacking psutil>=3.1.1 08:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:46:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:46:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:46:58 INFO - Installing collected packages: psutil 08:46:58 INFO - Running setup.py install for psutil 08:46:58 INFO - building 'psutil._psutil_linux' extension 08:46:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:46:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:46:58 INFO - building 'psutil._psutil_posix' extension 08:46:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:46:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:46:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:46:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:46:58 INFO - Successfully installed psutil 08:46:59 INFO - Cleaning up... 08:46:59 INFO - Return code: 0 08:46:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:46: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')]} 08:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46: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')]} 08:46:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0e08dfff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1299090>, '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 0x129c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129ce40>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1472571993.445385-1117785531', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:46: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:46: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 mozsystemmonitor==0.3 08:46:59 INFO - Using env: {'DISPLAY': ':0', 08:46:59 INFO - 'HOME': '/home/cltbld', 08:46:59 INFO - 'LANG': 'en_US.UTF-8', 08:46:59 INFO - 'LANGUAGE': 'en_US:en', 08:46:59 INFO - 'LOGNAME': 'cltbld', 08:46:59 INFO - 'MAIL': '/var/mail/cltbld', 08:46:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:59 INFO - 'MOZ_NO_REMOTE': '1', 08:46:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:59 INFO - 'NO_EM_RESTART': '1', 08:46:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:59 INFO - 'PWD': '/builds/slave/test', 08:46:59 INFO - 'SHELL': '/bin/bash', 08:46:59 INFO - 'SHLVL': '1', 08:46:59 INFO - 'TERM': 'linux', 08:46:59 INFO - 'TMOUT': '86400', 08:46:59 INFO - 'USER': 'cltbld', 08:46:59 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1472571993.445385-1117785531', 08:46:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:59 INFO - '_': '/tools/buildbot/bin/python'} 08:46:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:47:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:47:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:47:01 INFO - Installing collected packages: mozsystemmonitor 08:47:01 INFO - Running setup.py install for mozsystemmonitor 08:47:01 INFO - Successfully installed mozsystemmonitor 08:47:01 INFO - Cleaning up... 08:47:01 INFO - Return code: 0 08:47:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:47:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:47:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0e08dfff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1299090>, '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 0x129c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129ce40>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1472571993.445385-1117785531', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:47:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:47:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:47:01 INFO - Using env: {'DISPLAY': ':0', 08:47:01 INFO - 'HOME': '/home/cltbld', 08:47:01 INFO - 'LANG': 'en_US.UTF-8', 08:47:01 INFO - 'LANGUAGE': 'en_US:en', 08:47:01 INFO - 'LOGNAME': 'cltbld', 08:47:01 INFO - 'MAIL': '/var/mail/cltbld', 08:47:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:01 INFO - 'MOZ_NO_REMOTE': '1', 08:47:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:01 INFO - 'NO_EM_RESTART': '1', 08:47:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:01 INFO - 'PWD': '/builds/slave/test', 08:47:01 INFO - 'SHELL': '/bin/bash', 08:47:01 INFO - 'SHLVL': '1', 08:47:01 INFO - 'TERM': 'linux', 08:47:01 INFO - 'TMOUT': '86400', 08:47:01 INFO - 'USER': 'cltbld', 08:47:01 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1472571993.445385-1117785531', 08:47:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:01 INFO - '_': '/tools/buildbot/bin/python'} 08:47:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:01 INFO - Downloading/unpacking jsonschema==2.5.1 08:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:47:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:03 INFO - Downloading functools32-3.2.3-2.tar.gz 08:47:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:47:03 INFO - warning: no files found matching '*.txt' 08:47:03 INFO - no previously-included directories found matching 'build' 08:47:03 INFO - no previously-included directories found matching 'dist' 08:47:03 INFO - no previously-included directories found matching '.git*' 08:47:03 INFO - Installing collected packages: jsonschema, functools32 08:47:03 INFO - Running setup.py install for functools32 08:47:03 INFO - warning: no files found matching '*.txt' 08:47:03 INFO - no previously-included directories found matching 'build' 08:47:03 INFO - no previously-included directories found matching 'dist' 08:47:03 INFO - no previously-included directories found matching '.git*' 08:47:03 INFO - Successfully installed jsonschema functools32 08:47:03 INFO - Cleaning up... 08:47:03 INFO - Return code: 0 08:47:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:47:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:47:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0e08dfff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1299090>, '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 0x129c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129ce40>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1472571993.445385-1117785531', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:47:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:47:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:47:03 INFO - Using env: {'DISPLAY': ':0', 08:47:03 INFO - 'HOME': '/home/cltbld', 08:47:03 INFO - 'LANG': 'en_US.UTF-8', 08:47:03 INFO - 'LANGUAGE': 'en_US:en', 08:47:03 INFO - 'LOGNAME': 'cltbld', 08:47:03 INFO - 'MAIL': '/var/mail/cltbld', 08:47:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:03 INFO - 'MOZ_NO_REMOTE': '1', 08:47:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:03 INFO - 'NO_EM_RESTART': '1', 08:47:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:03 INFO - 'PWD': '/builds/slave/test', 08:47:03 INFO - 'SHELL': '/bin/bash', 08:47:03 INFO - 'SHLVL': '1', 08:47:03 INFO - 'TERM': 'linux', 08:47:03 INFO - 'TMOUT': '86400', 08:47:03 INFO - 'USER': 'cltbld', 08:47:03 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1472571993.445385-1117785531', 08:47:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:03 INFO - '_': '/tools/buildbot/bin/python'} 08:47:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:47:04 INFO - Cleaning up... 08:47:04 INFO - Return code: 0 08:47:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:47: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')]} 08:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47: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')]} 08:47:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47: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', '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 0x7f0e08dfff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1299090>, '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 0x129c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129ce40>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1472571993.445385-1117785531', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:47: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:47: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 blobuploader==1.2.4 08:47:04 INFO - Using env: {'DISPLAY': ':0', 08:47:04 INFO - 'HOME': '/home/cltbld', 08:47:04 INFO - 'LANG': 'en_US.UTF-8', 08:47:04 INFO - 'LANGUAGE': 'en_US:en', 08:47:04 INFO - 'LOGNAME': 'cltbld', 08:47:04 INFO - 'MAIL': '/var/mail/cltbld', 08:47:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:04 INFO - 'MOZ_NO_REMOTE': '1', 08:47:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:04 INFO - 'NO_EM_RESTART': '1', 08:47:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:04 INFO - 'PWD': '/builds/slave/test', 08:47:04 INFO - 'SHELL': '/bin/bash', 08:47:04 INFO - 'SHLVL': '1', 08:47:04 INFO - 'TERM': 'linux', 08:47:04 INFO - 'TMOUT': '86400', 08:47:04 INFO - 'USER': 'cltbld', 08:47:04 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1472571993.445385-1117785531', 08:47:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:04 INFO - '_': '/tools/buildbot/bin/python'} 08:47:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:04 INFO - Downloading/unpacking blobuploader==1.2.4 08:47: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 08:47: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 08:47: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 08:47: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 08:47: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 08:47: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 08:47:06 INFO - Downloading blobuploader-1.2.4.tar.gz 08:47:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:47:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:47:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:06 INFO - Downloading docopt-0.6.1.tar.gz 08:47:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:47:07 INFO - Installing collected packages: blobuploader, requests, docopt 08:47:07 INFO - Running setup.py install for blobuploader 08:47:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:47:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:47:07 INFO - Running setup.py install for requests 08:47:07 INFO - Running setup.py install for docopt 08:47:07 INFO - Successfully installed blobuploader requests docopt 08:47:07 INFO - Cleaning up... 08:47:07 INFO - Return code: 0 08:47:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:47: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')]} 08:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47: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')]} 08:47:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0e08dfff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1299090>, '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 0x129c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129ce40>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1472571993.445385-1117785531', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:47:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:47:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:47:07 INFO - Using env: {'DISPLAY': ':0', 08:47:07 INFO - 'HOME': '/home/cltbld', 08:47:07 INFO - 'LANG': 'en_US.UTF-8', 08:47:07 INFO - 'LANGUAGE': 'en_US:en', 08:47:07 INFO - 'LOGNAME': 'cltbld', 08:47:07 INFO - 'MAIL': '/var/mail/cltbld', 08:47:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:07 INFO - 'MOZ_NO_REMOTE': '1', 08:47:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:07 INFO - 'NO_EM_RESTART': '1', 08:47:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:07 INFO - 'PWD': '/builds/slave/test', 08:47:07 INFO - 'SHELL': '/bin/bash', 08:47:07 INFO - 'SHLVL': '1', 08:47:07 INFO - 'TERM': 'linux', 08:47:07 INFO - 'TMOUT': '86400', 08:47:07 INFO - 'USER': 'cltbld', 08:47:07 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1472571993.445385-1117785531', 08:47:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:07 INFO - '_': '/tools/buildbot/bin/python'} 08:47:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:47:07 INFO - Running setup.py (path:/tmp/pip-ZbnlG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:47:07 INFO - Running setup.py (path:/tmp/pip-sZiq24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:47:07 INFO - Running setup.py (path:/tmp/pip-AUiH0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:47:08 INFO - Running setup.py (path:/tmp/pip-EaazjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:47:08 INFO - Running setup.py (path:/tmp/pip-ZFFETF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:47:08 INFO - Running setup.py (path:/tmp/pip-lmxiy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:47:08 INFO - Running setup.py (path:/tmp/pip-9gtV6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:47:08 INFO - Running setup.py (path:/tmp/pip-1YEMTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:47:08 INFO - Running setup.py (path:/tmp/pip-vRIPy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:47:08 INFO - Running setup.py (path:/tmp/pip-bWOk7e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:47:08 INFO - Running setup.py (path:/tmp/pip-IwyMuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:47:08 INFO - Running setup.py (path:/tmp/pip-L08_9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:47:08 INFO - Running setup.py (path:/tmp/pip-UkQ5Gj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:47:08 INFO - Running setup.py (path:/tmp/pip-DskyPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:47:08 INFO - Running setup.py (path:/tmp/pip-Am8BwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:47:08 INFO - Running setup.py (path:/tmp/pip-jopS4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:47:08 INFO - Running setup.py (path:/tmp/pip-vGwIXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:47:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:47:09 INFO - Running setup.py install for manifestparser 08:47:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:47:09 INFO - Running setup.py install for mozcrash 08:47:09 INFO - Running setup.py install for mozdebug 08:47:09 INFO - Running setup.py install for mozdevice 08:47:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:47:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:47:09 INFO - Running setup.py install for mozfile 08:47:09 INFO - Running setup.py install for mozhttpd 08:47:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:47:09 INFO - Running setup.py install for mozinfo 08:47:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:47:09 INFO - Running setup.py install for mozInstall 08:47:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:47:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:47:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:47:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:47:09 INFO - Running setup.py install for mozleak 08:47:09 INFO - Running setup.py install for mozlog 08:47:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:47:10 INFO - Running setup.py install for moznetwork 08:47:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:47:10 INFO - Running setup.py install for mozprocess 08:47:10 INFO - Running setup.py install for mozprofile 08:47:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:47:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:47:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:47:10 INFO - Running setup.py install for mozrunner 08:47:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:47:10 INFO - Running setup.py install for mozscreenshot 08:47:10 INFO - Running setup.py install for moztest 08:47:10 INFO - Running setup.py install for mozversion 08:47:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:47:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:47:10 INFO - Cleaning up... 08:47:10 INFO - Return code: 0 08:47:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:47: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')]} 08:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47: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')]} 08:47:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0e08dfff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1299090>, '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 0x129c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129ce40>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1472571993.445385-1117785531', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:47:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:47:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:47:10 INFO - Using env: {'DISPLAY': ':0', 08:47:10 INFO - 'HOME': '/home/cltbld', 08:47:10 INFO - 'LANG': 'en_US.UTF-8', 08:47:10 INFO - 'LANGUAGE': 'en_US:en', 08:47:10 INFO - 'LOGNAME': 'cltbld', 08:47:10 INFO - 'MAIL': '/var/mail/cltbld', 08:47:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:10 INFO - 'MOZ_NO_REMOTE': '1', 08:47:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:10 INFO - 'NO_EM_RESTART': '1', 08:47:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:10 INFO - 'PWD': '/builds/slave/test', 08:47:10 INFO - 'SHELL': '/bin/bash', 08:47:10 INFO - 'SHLVL': '1', 08:47:10 INFO - 'TERM': 'linux', 08:47:10 INFO - 'TMOUT': '86400', 08:47:10 INFO - 'USER': 'cltbld', 08:47:10 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1472571993.445385-1117785531', 08:47:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:10 INFO - '_': '/tools/buildbot/bin/python'} 08:47:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:47:11 INFO - Running setup.py (path:/tmp/pip-Uaj8Og-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:47:11 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:47:11 INFO - Running setup.py (path:/tmp/pip-2KIw2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:47:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:47:11 INFO - Running setup.py (path:/tmp/pip-xLZkZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:47:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:47:11 INFO - Running setup.py (path:/tmp/pip-1ylLZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:47:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:47:11 INFO - Running setup.py (path:/tmp/pip-ZbQw_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:47:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:47:11 INFO - Running setup.py (path:/tmp/pip-WkLoLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:47:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:47:11 INFO - Running setup.py (path:/tmp/pip-RmHYwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:47:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:47:11 INFO - Running setup.py (path:/tmp/pip-6faqN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:47:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:47:11 INFO - Running setup.py (path:/tmp/pip-vyQ5AY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:47:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:47:11 INFO - Running setup.py (path:/tmp/pip-4itVPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:47:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:47:11 INFO - Running setup.py (path:/tmp/pip-X1gDgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:47:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:47:11 INFO - Running setup.py (path:/tmp/pip-rlHAba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:47:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:47:11 INFO - Running setup.py (path:/tmp/pip-dZAKJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:47:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:47:12 INFO - Running setup.py (path:/tmp/pip-IbaFwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:47:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:47:12 INFO - Running setup.py (path:/tmp/pip-snACVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:47:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:47:12 INFO - Running setup.py (path:/tmp/pip-2Q9azl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:47:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:47:12 INFO - Running setup.py (path:/tmp/pip-ddPxeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:47:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:47:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:47:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:47:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:47:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:47:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:47:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:14 INFO - Downloading blessings-1.6.tar.gz 08:47:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:47:14 INFO - Installing collected packages: blessings 08:47:14 INFO - Running setup.py install for blessings 08:47:14 INFO - Successfully installed blessings 08:47:14 INFO - Cleaning up... 08:47:14 INFO - Return code: 0 08:47:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:47:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:47:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:47:14 INFO - Reading from file tmpfile_stdout 08:47:14 INFO - Current package versions: 08:47:14 INFO - argparse == 1.2.1 08:47:14 INFO - blessings == 1.6 08:47:14 INFO - blobuploader == 1.2.4 08:47:14 INFO - docopt == 0.6.1 08:47:14 INFO - functools32 == 3.2.3-2 08:47:14 INFO - jsonschema == 2.5.1 08:47:14 INFO - manifestparser == 1.1 08:47:14 INFO - mozInstall == 1.12 08:47:14 INFO - mozcrash == 0.17 08:47:14 INFO - mozdebug == 0.1 08:47:14 INFO - mozdevice == 0.48 08:47:14 INFO - mozfile == 1.2 08:47:14 INFO - mozhttpd == 0.7 08:47:14 INFO - mozinfo == 0.9 08:47:14 INFO - mozleak == 0.1 08:47:14 INFO - mozlog == 3.3 08:47:14 INFO - moznetwork == 0.27 08:47:14 INFO - mozprocess == 0.23 08:47:14 INFO - mozprofile == 0.28 08:47:14 INFO - mozrunner == 6.12 08:47:14 INFO - mozscreenshot == 0.1 08:47:14 INFO - mozsystemmonitor == 0.3 08:47:14 INFO - moztest == 0.7 08:47:14 INFO - mozversion == 1.4 08:47:14 INFO - psutil == 3.1.1 08:47:14 INFO - requests == 1.2.3 08:47:14 INFO - wsgiref == 0.1.2 08:47:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:47:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:47:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0e08dfff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1299090>, '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 0x129c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129ce40>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1472571993.445385-1117785531', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:47:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:47:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:47:14 INFO - Using env: {'DISPLAY': ':0', 08:47:14 INFO - 'HOME': '/home/cltbld', 08:47:14 INFO - 'LANG': 'en_US.UTF-8', 08:47:14 INFO - 'LANGUAGE': 'en_US:en', 08:47:14 INFO - 'LOGNAME': 'cltbld', 08:47:14 INFO - 'MAIL': '/var/mail/cltbld', 08:47:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:14 INFO - 'MOZ_NO_REMOTE': '1', 08:47:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:14 INFO - 'NO_EM_RESTART': '1', 08:47:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:14 INFO - 'PWD': '/builds/slave/test', 08:47:14 INFO - 'SHELL': '/bin/bash', 08:47:14 INFO - 'SHLVL': '1', 08:47:14 INFO - 'TERM': 'linux', 08:47:14 INFO - 'TMOUT': '86400', 08:47:14 INFO - 'USER': 'cltbld', 08:47:14 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1472571993.445385-1117785531', 08:47:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:14 INFO - '_': '/tools/buildbot/bin/python'} 08:47:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:47:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:47:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:47:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:47:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:47:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:47:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:47:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:47:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:47:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:47:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:47:14 INFO - Cleaning up... 08:47:14 INFO - Return code: 0 08:47:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:47:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:47:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0e08dfff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1299090>, '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 0x129c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129ce40>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1472571993.445385-1117785531', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:47:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:47:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:47:14 INFO - Using env: {'DISPLAY': ':0', 08:47:14 INFO - 'HOME': '/home/cltbld', 08:47:14 INFO - 'LANG': 'en_US.UTF-8', 08:47:14 INFO - 'LANGUAGE': 'en_US:en', 08:47:14 INFO - 'LOGNAME': 'cltbld', 08:47:14 INFO - 'MAIL': '/var/mail/cltbld', 08:47:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:14 INFO - 'MOZ_NO_REMOTE': '1', 08:47:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:14 INFO - 'NO_EM_RESTART': '1', 08:47:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:14 INFO - 'PWD': '/builds/slave/test', 08:47:14 INFO - 'SHELL': '/bin/bash', 08:47:14 INFO - 'SHLVL': '1', 08:47:14 INFO - 'TERM': 'linux', 08:47:14 INFO - 'TMOUT': '86400', 08:47:14 INFO - 'USER': 'cltbld', 08:47:14 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1472571993.445385-1117785531', 08:47:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:14 INFO - '_': '/tools/buildbot/bin/python'} 08:47:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:47:15 INFO - Cleaning up... 08:47:15 INFO - Return code: 0 08:47:15 INFO - Running post-action listener: _resource_record_post_action 08:47:15 INFO - Running post-action listener: _start_resource_monitoring 08:47:15 INFO - Starting resource monitoring. 08:47:15 INFO - [mozharness: 2016-08-30 15:47:15.116740Z] Finished create-virtualenv step (success) 08:47:15 INFO - [mozharness: 2016-08-30 15:47:15.117243Z] Running install step. 08:47:15 INFO - Running pre-action listener: _resource_record_pre_action 08:47:15 INFO - Running main action method: install 08:47:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:47:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:47:15 INFO - Reading from file tmpfile_stdout 08:47:15 INFO - Detecting whether we're running mozinstall >=1.0... 08:47:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:47:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:47:15 INFO - Reading from file tmpfile_stdout 08:47:15 INFO - Output received: 08:47:15 INFO - Usage: mozinstall [options] installer 08:47:15 INFO - Options: 08:47:15 INFO - -h, --help show this help message and exit 08:47:15 INFO - -d DEST, --destination=DEST 08:47:15 INFO - Directory to install application into. [default: 08:47:15 INFO - "/builds/slave/test"] 08:47:15 INFO - --app=APP Application being installed. [default: firefox] 08:47:15 INFO - mkdir: /builds/slave/test/build/application 08:47:15 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'] 08:47:15 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 08:47:31 INFO - Reading from file tmpfile_stdout 08:47:31 INFO - Output received: 08:47:31 INFO - /builds/slave/test/build/application/firefox/firefox 08:47:31 INFO - Running post-action listener: _resource_record_post_action 08:47:31 INFO - [mozharness: 2016-08-30 15:47:31.544280Z] Finished install step (success) 08:47:31 INFO - [mozharness: 2016-08-30 15:47:31.544560Z] Running run-tests step. 08:47:31 INFO - Running pre-action listener: _resource_record_pre_action 08:47:31 INFO - Running main action method: run_tests 08:47:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:47:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:47:31 INFO - Python 2.7.3 08:47:31 INFO - Return code: 0 08:47:31 INFO - grabbing minidump binary from tooltool 08:47:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:47:31 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1299090>, '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 0x129c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129ce40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:47:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:47:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:47:31 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:47:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:47:31 INFO - Return code: 0 08:47:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:47:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:47:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:47:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:47:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:47:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XBOddpQWTCSS6QyaUAm_rw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:47:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XBOddpQWTCSS6QyaUAm_rw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:47:31 INFO - Using env: {'DISPLAY': ':0', 08:47:31 INFO - 'HOME': '/home/cltbld', 08:47:31 INFO - 'LANG': 'en_US.UTF-8', 08:47:31 INFO - 'LANGUAGE': 'en_US:en', 08:47:31 INFO - 'LOGNAME': 'cltbld', 08:47:31 INFO - 'MAIL': '/var/mail/cltbld', 08:47:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:47:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:47:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:31 INFO - 'MOZ_NO_REMOTE': '1', 08:47:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:47:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:31 INFO - 'NO_EM_RESTART': '1', 08:47:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:31 INFO - 'PWD': '/builds/slave/test', 08:47:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:47:31 INFO - 'SHELL': '/bin/bash', 08:47:31 INFO - 'SHLVL': '1', 08:47:31 INFO - 'TERM': 'linux', 08:47:31 INFO - 'TMOUT': '86400', 08:47:31 INFO - 'USER': 'cltbld', 08:47:31 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1472571993.445385-1117785531', 08:47:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:31 INFO - '_': '/tools/buildbot/bin/python'} 08:47:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XBOddpQWTCSS6QyaUAm_rw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:47:31 INFO - mozversion application_buildid: 20160830065621 08:47:31 INFO - mozversion application_changeset: b18c8bcdc116eef8799880b7c50317bf54218474 08:47:31 INFO - mozversion application_display_name: Nightly 08:47:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:47:31 INFO - mozversion application_name: Firefox 08:47:31 INFO - mozversion application_remotingname: firefox 08:47:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:47:31 INFO - mozversion application_vendor: Mozilla 08:47:31 INFO - mozversion application_version: 51.0a1 08:47:31 INFO - mozversion platform_buildid: 20160830065621 08:47:31 INFO - mozversion platform_changeset: b18c8bcdc116eef8799880b7c50317bf54218474 08:47:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:47:31 INFO - mozversion platform_version: 51.0a1 08:47:31 INFO - using testdate: 1472572051 08:47:31 INFO - actual date: 1472572051 08:47:31 INFO - starting webserver on 'localhost:33807' 08:47:31 INFO - SUITE-START | Running 2 tests 08:47:31 INFO - TEST-START | dromaeo_css 08:47:31 INFO - operating with platform_type : linux_ 08:47:31 INFO - Initialising browser for dromaeo_css test... 08:47:31 INFO - TEST-INFO | started process 28952 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsVP8ll/profile http://localhost:33807/getInfo.html) 08:47:36 INFO - PROCESS | 28952 | __metrics Screen width/height:1600/1200 08:47:36 INFO - PROCESS | 28952 | colorDepth:24 08:47:36 INFO - PROCESS | 28952 | Browser inner width/height: 1024/697 08:47:36 INFO - PROCESS | 28952 | __metrics 08:47:36 INFO - PROCESS | 28952 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:47:36 INFO - PROCESS | 28952 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:47:38 INFO - TEST-INFO | 28952: exit 0 08:47:38 INFO - Browser initialized. 08:47:38 INFO - Running cycle 1/1 for dromaeo_css test... 08:47:38 INFO - TEST-INFO | started process 29030 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsVP8ll/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:47:50 INFO - PROCESS | 29030 | RSS: Main: 181522432 08:47:50 INFO - PROCESS | 29030 | 08:48:41 INFO - PROCESS | 29030 | 1472572121268 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:50:54 INFO - PROCESS | 29030 | Cycle 1(1): loaded http://localhost:33807/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33807/tests/dromaeo/cssquery-ext.html) 08:50:55 INFO - PROCESS | 29030 | RSS: Main: 268132352 08:50:55 INFO - PROCESS | 29030 | 08:53:58 INFO - PROCESS | 29030 | Cycle 1(1): loaded http://localhost:33807/tests/dromaeo/cssquery-ext.html (next: http://localhost:33807/tests/dromaeo/cssquery-jquery.html) 08:53:58 INFO - PROCESS | 29030 | RSS: Main: 275464192 08:53:58 INFO - PROCESS | 29030 | 08:57:01 INFO - PROCESS | 29030 | Cycle 1(1): loaded http://localhost:33807/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33807/tests/dromaeo/cssquery-mootools.html) 08:57:01 INFO - PROCESS | 29030 | RSS: Main: 243146752 08:57:01 INFO - PROCESS | 29030 | 09:00:04 INFO - PROCESS | 29030 | Cycle 1(1): loaded http://localhost:33807/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33807/tests/dromaeo/cssquery-prototype.html) 09:00:04 INFO - PROCESS | 29030 | RSS: Main: 245194752 09:00:04 INFO - PROCESS | 29030 | 09:03:07 INFO - PROCESS | 29030 | Cycle 1(1): loaded http://localhost:33807/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33807/tests/dromaeo/cssquery-yui.html) 09:03:08 INFO - PROCESS | 29030 | RSS: Main: 219537408 09:03:08 INFO - PROCESS | 29030 | 09:06:11 INFO - PROCESS | 29030 | Cycle 1(1): loaded http://localhost:33807/tests/dromaeo/cssquery-yui.html (next: http://localhost:33807/tests/dromaeo/cssquery-dojo.html) 09:06:11 INFO - PROCESS | 29030 | RSS: Main: 310423552 09:06:11 INFO - PROCESS | 29030 | 09:06:11 INFO - PROCESS | 29030 | __start_tp_report 09:06:11 INFO - PROCESS | 29030 | _x_x_mozilla_page_load 09:06:11 INFO - PROCESS | 29030 | _x_x_mozilla_page_load_details 09:06:11 INFO - PROCESS | 29030 | |i|pagename|runs| 09:06:11 INFO - PROCESS | 29030 | |0;dojo.html;2561.628563858241;2577.7164511903698;2586.767190952814;2597.298729343077;2610.765031147196;4453.398791163192;4518.954810451894;4522.841700540482;4549.863504094882;4609.769511524423;4513.796879140438;4562.1788078146;4571.497135315112;4574.97712511437;4589.632829373651;4258.680598955075;4260.531341552427;4280.464941882265;4295.871123866274;4348.086901750637;4143.606357396043;4283.057727300004;4301.6988810783105;4307.5261721210645;4351.630111440531;4288.592583704543;4331.43691320128;4357.085012147453;4357.869263922087;4359.738415695053;4143.109231515239;4186;4257.936130958038;4292.484901811787;4308.224519586473;4118.279301122321;4156.792160391999;4162;4163.063310755087;4173.10278290169;4499.75251361175;4572.199865023607;4575.084983003379;4583.289590113538;4587.1513769952335;4767.785449654774;4825.179719447702;4887.853364399074;4897.4857639948;4941.135301322254;4855.077535268288;4883.8779030524165;4890.437599676047;4895.5838753705975;4908.975455122737;4574.794134263966;4576.290674945389;4583.197940360424;4593.26507758757;4638;4896.143174944442;4940.975295123501;4985.177445721488;5008.524190201925;5016.648834581617;4792.065547218329;4798.304245884327;4862.05189987949;4868.075065737498;4877.829275975324;4873.463918968911;4889.022195560902;4889.682170658896;4890.095332363524;4948.38145231846;4848.393950756155;4856.125897338442;4857.2228443449585;4862.635302352338;4909.4354149273295;4726.196546587088;4784.856454306377;4791.401074865642;4839.225723884232;4840.056189043174;4107.958920410817;4142.047329114261;4147.419361289422;4147.771872547039;4147.958520414757;3608.8376023079027;3645.76302540334;3702.4816525686424;3708.1100535871196;3708.2398108387715;4251.043515209115;4252.022034931983;4291.892702682458;4296.312589985588;4310.849120280775;4855.927161092586;4864.73243971585;4889.706617602955;4900.362952816183;4947.25791131326;4161.687873409506;4212.894677633084;4238.618524332764;4253.3619957006695;4301.78491075445;4390.209762242763;4413.889652758642;4418.977905110518;4463.464384273908;4472.351509031172;4646.210144275414;4646.790894409692;4650.767461626838;4706.294055891575;4728.290756386569;4774.045190961752;4807.6394270429155;4914.041761856403;4922.089413458379;4929.753512324298;4616.584507394351;4631.698939568917;4634.4670362907345;4688.695234809727;4697.0840686065885;4817.349657796293;4817.397825271841;4824.589909857561;4829.468758436499;4886.87601851569;4714.693544919569;4836.250381190921;4864.175640272169;4882.414110306786;4937.802487900443;4755.714657120584;4758.643101767312;4776.832810851603;4834.299026641188;4836.637252206169;4765.785539650655;4769.856904292877;4776.856694299037;4777.665563410528;4834.758262086812;4586.610138138162;4686.953130468788;4706.527154957648;4723.409573803275;4754.928676069792;4771.451283102488;4785.832495862628;4810.927836082392;4853.441854186673;4867.245576935581;4688.296755486705;4709.693869898446;4716.551927566876;4733.597644200281;4773.71357718538 09:06:11 INFO - PROCESS | 29030 | |1;ext.html;554.1825806934771;555.4584280326682;560.7252446301313;561.7444062951357;569.4504802865234;37895.43156852646;39915.60084399155;39954.80022599883;40061.599384006186;43496.782516087376;39908.201835963264;40388.79805600975;40490.19019619606;40497.392539111934;40781.796091019576;7641.61791910405;7779.183185765498;7782.105057918327;7791.493552919071;7795.18150594188;7623;7670.041244844395;7696.461247712662;7697.538147711127;7709;7749.612519374037;7775.6500957456765;7780.961095194516;7783.299503044725;7784;7648.196939321402;7684.193159718233;7708.845823083563;7725.690972361099;7734.5359278443475;7482.401407887356;7549.7357592483995;7550.207228241011;7554;7572.129205141369;37914.24171516554;38373;38377.808110959544;38379.8081009596;38397.200349956256;2841.687414384416;3015.532592448152;3114.98442507786;3343.7325013999066;3383.2387712764676;28433.3085040968;28511.714882851113;28554.571681424586;28578;29070.854645726635;3498.2828520153307;3520.260745243502;3564;3601.243738814852;3730.981345093257;241142;241631;241635;242286;242998;31958.36083278368;33127.33745325128;51348;51550.22674659883;51727.48272517227;32883.34233315368;33066.504002439986;33153.33693326168;33166.66833331636;33197.668023319944;11474.655760327203;11476.54093836254;11521.07831373488;11521.193516453935;11578.421078946187;9633.421994680342;9680.903190968;9693.41839489633;9695.418274903528;9704.75738106553;7653.502522336031;7698.230176982257;7707.383409327241;7711.113221979432;7785.455018148676;3009.5485677148167;3022.3199780049313;3053.5114381698822;3065.1417603071177;3071.616047994001;803.5580430763057;804.6137853830194;850.4854562989426;866.8049688819965;879.090141703334;26286.47427051448;26876.59685104725;27161.320966975985;27375.315617109733;27481;726.8800647893144;830.9002919649681;846.2933450568721;874.2874557235832;923.4966943016072;12995.28525931064;14095.929520352332;14108.15351078918;14131.929340353438;14222.502212422516;370878;371060;373482;375090;375217;47301.52698472971;47856.282155767694;47891.521084789405;47995.280070798966;48076;941.087145468894;1081.9621313254;1087.141158484788;1105.701460605632;1112.3548341961805;26932.865335673196;27873.58189627198;29192.31189905578;29213.415731685673;29533;40920.386194207706;41382.79308603438;41432;41456;41474.79262603788;235133;235242;235313;235902;236126;21575.46061348479;22040;22227.999740012063;22269.220577279717;22318.776812232318;37876.62123378731;38524;40508;41170;42002.57997419986;34154.82922585371;34251.486227706104;34265;34292.31415371629;34407.65592344045;33108.503372449915;34854.65145348514;34867.65132348746;35084.29831403409;35248.823755882084;34441.48337774986;34963.951081467596;35448.645513544536;35653.28693426169;35724.10689732777;30228.546571801002;32431.837840810644;32439.351212976082;32561.511577325884;32922.67077329196;23827.629911280128;24294.757052429955;24533.157439749408;24854.378640533407;24974.250772476855 09:06:11 INFO - PROCESS | 29030 | |2;jquery.html;336.8467347356953;355.84342889128783;360.4035321542847;363.4439307858975;381.5769861380236;12599.874001259985;15005.024673396236;16208.108554029524;16278.593035174126;16384.18079096045;14836.703265934675;15264.465743698973;15371.385144594231;15463.922680386582;15577.221138943065;5035.194368900977;5061;5256.632035757499;5276.894462110756;5277.234800953859;3722.274156539476;5162.896742065156;5250.343707036621;5893.941060589382;6198.628082315053;6156.998975333012;6158.476529494998;6162.969185154068;6164.075388691687;6171;5949.048152295633;6035.6680382578725;6093.238345206849;6105.9694701526205;6110.572259941806;5082.440931497532;5313.256144139824;5321.813736519242;5323.068463018956;5327.147656374961;20008.799032106457;20290.898545507327;20298.797012029987;20616.793832061787;20640.69038964417;1605.6226786705115;1687.2070127040272;1776.9555761105946;1860.4046705054388;2546.4907018596355;8782.60478278479;9196.448213107167;9359.20446762026;9574.90425095747;9663.130318271318;1737.8435940765266;1752.2027477497836;1764.1267572551542;1790.883592566479;1802.8918264904148;63583.68208158976;66569;67631;69242;69510.30489695088;9512.191463725661;9721.756956076155;9752.171065459373;9804.754881128029;9805.705828825146;12653.557125500563;12654.114212005255;12732.936335318263;12739.808902866464;12760.106792524433;6863.38229559342;6923.6192009439965;7057.329553692391;7089.964550177217;7099.858002839915;6337.524685648595;6377.139086223393;6390.0734393512685;6551.050097735897;6605.306442823435;3704.2591481703766;3733.8506459741848;4009.1981603679383;4182.749035057906;4203.495580530356;1766.1169415292354;1786.2497750944635;1800.207908520247;1804.440623406748;1818.4362847517311;755.5617741709796;771.028504084846;778.9961050194826;813.4143416739938;819.2053707903324;15913.602159946095;16448.506544803677;16836.24236909342;17291.91354043222;17517.38689145899;745.671904362079;815.657423881971;831.7089018843477;848.5672307123411;872.8908886389202;9073.59168837404;9122.771930701785;9347.626094956126;9353.859692104625;9588.904110958802;276270;281796;353312;355882;356506;46723.29915051277;54033.45966540284;60352.698236508535;65652;70156;912.8767616371838;924.0666926404245;931.7158266728577;944.9291303152291;992.5087081894509;14851.108933464027;15244.542663720105;15427.84572154264;15569.532914012598;15999.760003599722;25214.991400344516;28922.132336029954;37314.62685373111;37844.243115138095;38114;49666.75166624288;50116.49883501118;50318;50515.747421262655;50742.492575073775;7217.24218957002;7429;7590.620468976639;7632;7816.4137689674635;8421.410501264852;11291.43542822872;11432.542698292307;11671.474783634587;11691.707707307045;10011.348127559162;10215.94892025535;10266.845997309896;10291.897081029094;10516.947415263181;4535.614472769851;9449.858252126087;10090.798184036425;10120.190384769348;10564.841527376942;10231.7442063949;10508.78982420332;10689.786204276026;10778.353298802096;10794.244402891722;7062.15254169503;7071.43428525727;7148.749793757193;7308.123025237006;7550.5469671819865;9357.298202634693;9614.663486777928;9796.922338542612;9993.550290236812;10388.740281493023 09:06:11 INFO - PROCESS | 29030 | |3;mootools.html;1304.8303720516335;1339.1161833190097;1380.3236414157059;1624.5045261195346;1663.8918470299423;6930.480213983952;7459.142198647157;7469.02902622659;7486.775396738107;7674.2709442603;6470.9029364559565;7123.9287607123915;7366.963165184166;7400.185979542246;7471.1408188058385;2131.072983252286;2153.257126291427;2176.3144609448054;2179.7820217978233;2180.018991453844;2163.8485306028583;2201.757806641268;2208.3043841189974;2208.8012078912893;2211.2039665720326;1860.0513737993654;2089.550746589483;2161.373201771484;2165.8375621828345;2167.5339801942578;2153.095699806085;2156.4285464351883;2172.5872084303933;2176.4885251965934;2178.880161591112;2146.5921474919714;2150.817180539656;2153.569286142762;2154.644483660194;2155.708979287792;7521.887171692429;7532.13380461243;7561.395088392916;7564.810879727996;7597.734079307198;4189.560096189886;4191.664666826647;4236.830526778926;4238.87283381499;4246.745195288293;2732.8686389499367;2855.842928638924;2869.110575721533;2877.9712202877913;2883.1494709060876;885.7475619448426;916.9724908252697;934.444005816538;949.4682977532535;950.5484894675043;9647.614095436174;9703;9712.174465170398;9714.659986900424;9747.610095596168;3851.768893866377;3975.940360894589;4052.5744796796503;4139.130782535702;4160.375943608423;8484.872726909101;8518.148185181557;8519.659213631508;8520.147985201555;8531.701390451304;4235.618794308527;4274.743515389025;4275.0594869128745;4279.293916503742;4290.806913688892;3853.5183102112237;3879.398693202558;3884.126071633916;3885.805709714503;3910.178862438863;3213.5983002124735;3345.5985281766343;3368.949465758016;3375.4599264117624;3420.572428446444;1019.5513973851481;1033.9896601034043;1045.6497073480468;1048.8269435543202;1052.6894566103017;633.4014356433127;657.81252343082;685.5441131647399;688.5834070387443;792.5482474989316;4617.607503362252;4715.481297057321;4755.714657120584;4768.1417344878255;4901.852944411602;734.2363941500779;774.3340726974798;781.8788087846393;790.8457850719169;819.5451524404014;3136;3215.951760723591;3260.396826587089;3278.770486066;3379.3579219948133;8801.779955501164;8805.69180078694;8827.602757875911;8952.507612081397;9207.539623018822;8771.824563508693;8785.428947118417;8800.119988001277;8809.603567839462;8827.823443531093;6852.931470685329;6972.442204623618;6980.813261745516;6984.02223688684;6993.160820701447;4686.133065382915;4692.9530704692515;4736.076465089274;4793.23308270675;4804.495527969513;8232.135625759209;8295.668173273001;8308.958455207685;8338.62476188585;8342.624581893708;8372.413931025014;8544.572771361283;8631;8642.135786421308;8643.913560864563;6080.391960803884;6335.556511044183;6372.58578192416;6503.154589903283;6509.674516274262;6989.231184569591;7031.472639551952;7034.718611255493;7046.436285097282;7050.858982820418;6141.447269745744;6173.6913154343;6175.320714721467;6177.4749146323065;6321.051842223519;5949.791757288474;6050.788222412194;6145.508359331154;6261.843453913689;6335.3981371769605;5645.830625081254;5740.712964351682;5752.741126649227;5753.05074662676;5753.942460575341;4017.5178978522763;4036.5156181258435;4096.32410652239;4112.259793237126;4223.113146239324;4119.732217405859;4178.561251068716;4317.201317756225;4346.934795978;4348.565143485626 09:06:11 INFO - PROCESS | 29030 | |4;prototype.html;286.30713672911565;298.75352833912024;304.451986424436;304.6603037613061;307.7953161147837;4645.976770116153;4710.880103953226;4761.523847615237;4806.923568915888;4819.807207711691;4531.071130418264;4659.231226847566;4696.624270058395;4698.483166851644;4712;3761.1913438610695;3761.755485893422;3766.133789228479;3768.8869333920024;3775.5658099318584;3552.573691157052;3622.7826330420257;3758.2859256741267;3787.3182827091114;3790.223004284129;3718.4980027696183;3722.776633401991;3723.7951912644794;3729.1236559408517;3732.701383889282;3712.7029837612927;3724.9255014899823;3730.8694195703292;3738.5700644425965;3738.8504459821575;3270.7546933980047;3271.689189527015;3272.4436845736045;3280.442324804765;3299.538064670948;4494.628370971286;4628.81965098901;4673.182193116191;4679.766011699436;4682.1103990241745;4278.251306021434;4280.978595107035;4283.657307415399;4302.41917341158;4308.879691280258;4990.525900039491;5058.570021548173;5059.696418214919;5063.569596584295;5064.468230835746;3389.711874490671;3556.7551357024836;3687.539057617798;3694.5751238607636;3696.537932758405;5180.766865491062;5193.870153246161;5195.402528709171;5200.29795977542;5202.245674377232;3636.5999740028574;3637.217998130415;3637.4543818427446;3637.745357824927;3639.454081887685;3692.280005398975;3693.759905606181;3693.8891833245048;3720.3675375186285;3734.421164719473;4026;4193.20329137469;4204.873853784391;4227.302495088337;4261.147770445923;4995.17579599362;4998.625103117281;5002.52476014778;5006.974965125224;5016.347874776256;1205.1142410328403;1242.6082787278126;1258.8426446694164;1265;1273.4333221716247;856.5674334461057;857.5455008845322;869.2350731356366;876.5003947749722;881.8192270584515;4373.66603186025;4378.277584198571;4390.165868484977;4411.18393097278;4415.933760993587;5050.535344749981;5054.494550544916;5083.881546059861;5087.26234695967;5100.183970564692;4362.956370436255;4363.912721745611;4384.758838263926;4391.67062470316;4415.161119387306;2293.8508996915148;2370.7510711375057;2396.496735685491;2400.1039179048357;2401.3876461502205;4293.141371725605;4311.805968731414;4337.82648694055;4353;4359.956400435955;4609.124266389375;4629.213033784265;4648.535711251013;4648.790804413742;4662.953370466252;4153.418521407006;4285.871423857289;4293.463317085364;4324.113751460829;4329.437173167531;4474;4491.529658687774;4500.684952053325;4516.435445569304;4522.773861306856;4419.447569053868;4452.755098469615;4471.239889218776;4471.28459446487;4476.664250181184;4181.18118618402;4267.930053923907;4277.401163837128;4322.622557593374;4338.6312163466455;3337.6803121831067;3341.682540158681;3343.3313337333116;3360.428727116347;3371.7524515929263;4521.886952826206;4526.2305408081365;4547.6584407599175;4557.293619488984;4832.767644250694;4746.216874215854;4977.527134922177;5003.373229054775;5012.967154871396;5028.572571331331;5008.323876276656;5023.095842748195;5023.120953833138;5035.29505869186;5046.646734728533;4816.386510518875;4962.841164093631;4975.925361119658;4979.356812252021;4987.177115775857;5044.385796545071;5047.798088076436;5061.190209566452;5063.873403164803;5074.695518268915;4880.267959805916;4924.950750492592;4929.8907745756915;4946.925796112989;4968.627352948615 09:06:11 INFO - PROCESS | 29030 | |5;yui.html;636.3922454056379;641.9133416988706;644.6067898581865;707.9327463890932;732.7435397610835;12242.204256723307;12702.110852240347;12722.872771272285;12726.618201453959;12734.617961461148;13190.802137967914;13274.269915154662;13298.601041968732;13305.13516621419;13366.131201471897;595.6991719181829;716.4554938246931;718.6550455781228;746.0525133080984;746.3394895517479;740.2597402597403;745.6905384265523;745.697992313114;746.0450623202282;746.0860445953717;786.2098590916121;787.4251796188786;787.6337503061076;787.6967367563471;787.8069872881152;621.5928566788738;637.7799659117597;638.2532437048618;639.587466084373;789;559.0942672869977;574.22192928582;579.5161040531161;579.6927628356977;579.7043507811004;12898.80651790224;12923.741525169538;12943.417546210443;12947.87052129476;12952.028597855198;11368.772624547546;11620.883791162149;11712.297262164297;11953.342566158857;12186.2078964867;11702.2978621283;11819.645410637695;11898;11925.522979080914;12275.386230688518;3859.363205071188;3873.4383514390256;3906.8632597858937;4011.29802284599;4056.7565946043037;64551.35448645547;66900.6654966727;66982;67036.3296367035;67064.3293567063;8628.827423451496;9103.408278462011;9231.399959002643;9311;10186.286959912735;18459.353922612645;18787;18813.529661758566;18815.153318100718;18844.717329240073;6605.393193568751;6611.404973552307;6621.33786621334;6842.589444633239;6858.725650973905;3501.9474707879403;3506.561679790026;3507.6667716567395;3596.2268112355446;3687.1703866629796;2622.10848311575;2724.6594175728032;2732.904348347838;2733.8223015503927;2734.5624700047897;464.8698364457957;471.5543811098479;478.4450037955954;479.8368554691352;485.31812803011826;405.1047185719534;414.91909077730156;427.9486461624625;443.58303194996597;457.9450465944108;6545.247296560957;6615.933840661628;6801.931980680229;7064.081669382947;7122.7507037253445;391.63773509504165;430.84318604546894;492.2591499792789;507.974601269935;513.4557369188672;3334.4664853623303;3461.238527523941;3480.390931587013;3508.3509550733197;3615.3492371373404;53439.46560534422;53560;53708.731456342466;75792;79932.60033699794;76880.23119768842;77914.6104269475;78739.60630196812;78804.60597696975;79499.20500795034;65378.67310663416;69899.66053564302;71273.28726712667;73358.26641733514;73401.6329918347;7862.135165131716;7870.488418252795;7919.722809701633;7946.920530794618;8084.83830323402;42295.7885210572;42616;42798.78600606977;43314.133717326105;44465.11069778522;54443.45556544384;57057.42942570687;58491.70754146202;60817.391826082945;64341.678291608245;9998.500074996076;10394.376337419477;10423.583056677648;10511.94744026275;10523.210759193244;10746.660958477918;11156.44217789091;11411.942940285246;11632.592859249886;12122.575709850113;9998;10195.949020254851;10248.846267305848;10862.125405469475;11061.5022323994;10333.431661258703;10848;10916.235863489797;10930;11160.051395631463;10130.392176469435;10256.948715256376;10614.363138211733;11099.557057582462;11137.665870023913;9047.638094476148;9291.72124836256;9524.571394287135;9596.328257021942;9729.4648794317;9215.723528294162;9585.856212156683;9593.472359020321;9618.615255389706;9673.516324183622 09:06:11 INFO - PROCESS | 29030 | __end_tp_report 09:06:11 INFO - PROCESS | 29030 | __start_cc_report 09:06:11 INFO - PROCESS | 29030 | _x_x_mozilla_cycle_collect,973 09:06:11 INFO - PROCESS | 29030 | __end_cc_report 09:06:11 INFO - PROCESS | 29030 | __startTimestamp1472573171922__endTimestamp 09:06:11 INFO - PROCESS | 29030 | 09:06:11 INFO - PROCESS | 29030 | ------- Summary: start ------- 09:06:11 INFO - PROCESS | 29030 | Number of tests: 6 09:06:11 INFO - PROCESS | 29030 | 09:06:11 INFO - PROCESS | 29030 | [#0] dojo.html Cycles:165 Average:4533.28 Median:4686.95 stddev:457.62 (9.8%) stddev-sans-first:432.09 09:06:11 INFO - PROCESS | 29030 | Values: 2561.6 2577.7 2586.8 2597.3 2610.8 4453.4 4519.0 4522.8 4549.9 4609.8 4513.8 4562.2 4571.5 4575.0 4589.6 4258.7 4260.5 4280.5 4295.9 4348.1 4143.6 4283.1 4301.7 4307.5 4351.6 4288.6 4331.4 4357.1 4357.9 4359.7 4143.1 4186.0 4257.9 4292.5 4308.2 4118.3 4156.8 4162.0 4163.1 4173.1 4499.8 4572.2 4575.1 4583.3 4587.2 4767.8 4825.2 4887.9 4897.5 4941.1 4855.1 4883.9 4890.4 4895.6 4909.0 4574.8 4576.3 4583.2 4593.3 4638.0 4896.1 4941.0 4985.2 5008.5 5016.6 4792.1 4798.3 4862.1 4868.1 4877.8 4873.5 4889.0 4889.7 4890.1 4948.4 4848.4 4856.1 4857.2 4862.6 4909.4 4726.2 4784.9 4791.4 4839.2 4840.1 4108.0 4142.0 4147.4 4147.8 4148.0 3608.8 3645.8 3702.5 3708.1 3708.2 4251.0 4252.0 4291.9 4296.3 4310.8 4855.9 4864.7 4889.7 4900.4 4947.3 4161.7 4212.9 4238.6 4253.4 4301.8 4390.2 4413.9 4419.0 4463.5 4472.4 4646.2 4646.8 4650.8 4706.3 4728.3 4774.0 4807.6 4914.0 4922.1 4929.8 4616.6 4631.7 4634.5 4688.7 4697.1 4817.3 4817.4 4824.6 4829.5 4886.9 4714.7 4836.3 4864.2 4882.4 4937.8 4755.7 4758.6 4776.8 4834.3 4836.6 4765.8 4769.9 4776.9 4777.7 4834.8 4586.6 4687.0 4706.5 4723.4 4754.9 4771.5 4785.8 4810.9 4853.4 4867.2 4688.3 4709.7 4716.6 4733.6 4773.7 09:06:11 INFO - PROCESS | 29030 | 09:06:11 INFO - PROCESS | 29030 | [#1] ext.html Cycles:180 Average:42700.48 Median:370969.00 stddev:76583.40 (20.6%) stddev-sans-first:76732.86 09:06:11 INFO - PROCESS | 29030 | Values: 554.2 555.5 560.7 561.7 569.5 37895.4 39915.6 39954.8 40061.6 43496.8 39908.2 40388.8 40490.2 40497.4 40781.8 7641.6 7779.2 7782.1 7791.5 7795.2 7623.0 7670.0 7696.5 7697.5 7709.0 7749.6 7775.7 7781.0 7783.3 7784.0 7648.2 7684.2 7708.8 7725.7 7734.5 7482.4 7549.7 7550.2 7554.0 7572.1 37914.2 38373.0 38377.8 38379.8 38397.2 2841.7 3015.5 3115.0 3343.7 3383.2 28433.3 28511.7 28554.6 28578.0 29070.9 3498.3 3520.3 3564.0 3601.2 3731.0 241142.0 241631.0 241635.0 242286.0 242998.0 31958.4 33127.3 51348.0 51550.2 51727.5 32883.3 33066.5 33153.3 33166.7 33197.7 11474.7 11476.5 11521.1 11521.2 11578.4 9633.4 9680.9 9693.4 9695.4 9704.8 7653.5 7698.2 7707.4 7711.1 7785.5 3009.5 3022.3 3053.5 3065.1 3071.6 803.6 804.6 850.5 866.8 879.1 26286.5 26876.6 27161.3 27375.3 27481.0 726.9 830.9 846.3 874.3 923.5 12995.3 14095.9 14108.2 14131.9 14222.5 370878.0 371060.0 373482.0 375090.0 375217.0 47301.5 47856.3 47891.5 47995.3 48076.0 941.1 1082.0 1087.1 1105.7 1112.4 26932.9 27873.6 29192.3 29213.4 29533.0 40920.4 41382.8 41432.0 41456.0 41474.8 235133.0 235242.0 235313.0 235902.0 236126.0 21575.5 22040.0 22228.0 22269.2 22318.8 37876.6 38524.0 40508.0 41170.0 42002.6 34154.8 34251.5 34265.0 34292.3 34407.7 33108.5 34854.7 34867.7 35084.3 35248.8 34441.5 34964.0 35448.6 35653.3 35724.1 30228.5 32431.8 32439.4 32561.5 32922.7 23827.6 24294.8 24533.2 24854.4 24974.3 09:06:11 INFO - PROCESS | 29030 | 09:06:11 INFO - PROCESS | 29030 | [#2] jquery.html Cycles:180 Average:21623.80 Median:27788.37 stddev:54047.78 (194.5%) stddev-sans-first:54175.76 09:06:11 INFO - PROCESS | 29030 | Values: 336.8 355.8 360.4 363.4 381.6 12599.9 15005.0 16208.1 16278.6 16384.2 14836.7 15264.5 15371.4 15463.9 15577.2 5035.2 5061.0 5256.6 5276.9 5277.2 3722.3 5162.9 5250.3 5893.9 6198.6 6157.0 6158.5 6163.0 6164.1 6171.0 5949.0 6035.7 6093.2 6106.0 6110.6 5082.4 5313.3 5321.8 5323.1 5327.1 20008.8 20290.9 20298.8 20616.8 20640.7 1605.6 1687.2 1777.0 1860.4 2546.5 8782.6 9196.4 9359.2 9574.9 9663.1 1737.8 1752.2 1764.1 1790.9 1802.9 63583.7 66569.0 67631.0 69242.0 69510.3 9512.2 9721.8 9752.2 9804.8 9805.7 12653.6 12654.1 12732.9 12739.8 12760.1 6863.4 6923.6 7057.3 7090.0 7099.9 6337.5 6377.1 6390.1 6551.1 6605.3 3704.3 3733.9 4009.2 4182.7 4203.5 1766.1 1786.2 1800.2 1804.4 1818.4 755.6 771.0 779.0 813.4 819.2 15913.6 16448.5 16836.2 17291.9 17517.4 745.7 815.7 831.7 848.6 872.9 9073.6 9122.8 9347.6 9353.9 9588.9 276270.0 281796.0 353312.0 355882.0 356506.0 46723.3 54033.5 60352.7 65652.0 70156.0 912.9 924.1 931.7 944.9 992.5 14851.1 15244.5 15427.8 15569.5 15999.8 25215.0 28922.1 37314.6 37844.2 38114.0 49666.8 50116.5 50318.0 50515.7 50742.5 7217.2 7429.0 7590.6 7632.0 7816.4 8421.4 11291.4 11432.5 11671.5 11691.7 10011.3 10215.9 10266.8 10291.9 10516.9 4535.6 9449.9 10090.8 10120.2 10564.8 10231.7 10508.8 10689.8 10778.4 10794.2 7062.2 7071.4 7148.7 7308.1 7550.5 9357.3 9614.7 9796.9 9993.6 10388.7 09:06:11 INFO - PROCESS | 29030 | 09:06:11 INFO - PROCESS | 29030 | [#3] mootools.html Cycles:180 Average:4798.27 Median:5693.27 stddev:2662.68 (46.8%) stddev-sans-first:2657.20 09:06:11 INFO - PROCESS | 29030 | Values: 1304.8 1339.1 1380.3 1624.5 1663.9 6930.5 7459.1 7469.0 7486.8 7674.3 6470.9 7123.9 7367.0 7400.2 7471.1 2131.1 2153.3 2176.3 2179.8 2180.0 2163.8 2201.8 2208.3 2208.8 2211.2 1860.1 2089.6 2161.4 2165.8 2167.5 2153.1 2156.4 2172.6 2176.5 2178.9 2146.6 2150.8 2153.6 2154.6 2155.7 7521.9 7532.1 7561.4 7564.8 7597.7 4189.6 4191.7 4236.8 4238.9 4246.7 2732.9 2855.8 2869.1 2878.0 2883.1 885.7 917.0 934.4 949.5 950.5 9647.6 9703.0 9712.2 9714.7 9747.6 3851.8 3975.9 4052.6 4139.1 4160.4 8484.9 8518.1 8519.7 8520.1 8531.7 4235.6 4274.7 4275.1 4279.3 4290.8 3853.5 3879.4 3884.1 3885.8 3910.2 3213.6 3345.6 3368.9 3375.5 3420.6 1019.6 1034.0 1045.6 1048.8 1052.7 633.4 657.8 685.5 688.6 792.5 4617.6 4715.5 4755.7 4768.1 4901.9 734.2 774.3 781.9 790.8 819.5 3136.0 3216.0 3260.4 3278.8 3379.4 8801.8 8805.7 8827.6 8952.5 9207.5 8771.8 8785.4 8800.1 8809.6 8827.8 6852.9 6972.4 6980.8 6984.0 6993.2 4686.1 4693.0 4736.1 4793.2 4804.5 8232.1 8295.7 8309.0 8338.6 8342.6 8372.4 8544.6 8631.0 8642.1 8643.9 6080.4 6335.6 6372.6 6503.2 6509.7 6989.2 7031.5 7034.7 7046.4 7050.9 6141.4 6173.7 6175.3 6177.5 6321.1 5949.8 6050.8 6145.5 6261.8 6335.4 5645.8 5740.7 5752.7 5753.1 5753.9 4017.5 4036.5 4096.3 4112.3 4223.1 4119.7 4178.6 4317.2 4346.9 4348.6 09:06:11 INFO - PROCESS | 29030 | 09:06:11 INFO - PROCESS | 29030 | [#4] prototype.html Cycles:180 Average:4025.05 Median:4390.92 stddev:1160.56 (26.4%) stddev-sans-first:1129.38 09:06:11 INFO - PROCESS | 29030 | Values: 286.3 298.8 304.5 304.7 307.8 4646.0 4710.9 4761.5 4806.9 4819.8 4531.1 4659.2 4696.6 4698.5 4712.0 3761.2 3761.8 3766.1 3768.9 3775.6 3552.6 3622.8 3758.3 3787.3 3790.2 3718.5 3722.8 3723.8 3729.1 3732.7 3712.7 3724.9 3730.9 3738.6 3738.9 3270.8 3271.7 3272.4 3280.4 3299.5 4494.6 4628.8 4673.2 4679.8 4682.1 4278.3 4281.0 4283.7 4302.4 4308.9 4990.5 5058.6 5059.7 5063.6 5064.5 3389.7 3556.8 3687.5 3694.6 3696.5 5180.8 5193.9 5195.4 5200.3 5202.2 3636.6 3637.2 3637.5 3637.7 3639.5 3692.3 3693.8 3693.9 3720.4 3734.4 4026.0 4193.2 4204.9 4227.3 4261.1 4995.2 4998.6 5002.5 5007.0 5016.3 1205.1 1242.6 1258.8 1265.0 1273.4 856.6 857.5 869.2 876.5 881.8 4373.7 4378.3 4390.2 4411.2 4415.9 5050.5 5054.5 5083.9 5087.3 5100.2 4363.0 4363.9 4384.8 4391.7 4415.2 2293.9 2370.8 2396.5 2400.1 2401.4 4293.1 4311.8 4337.8 4353.0 4360.0 4609.1 4629.2 4648.5 4648.8 4663.0 4153.4 4285.9 4293.5 4324.1 4329.4 4474.0 4491.5 4500.7 4516.4 4522.8 4419.4 4452.8 4471.2 4471.3 4476.7 4181.2 4267.9 4277.4 4322.6 4338.6 3337.7 3341.7 3343.3 3360.4 3371.8 4521.9 4526.2 4547.7 4557.3 4832.8 4746.2 4977.5 5003.4 5013.0 5028.6 5008.3 5023.1 5023.1 5035.3 5046.6 4816.4 4962.8 4975.9 4979.4 4987.2 5044.4 5047.8 5061.2 5063.9 5074.7 4880.3 4925.0 4929.9 4946.9 4968.6 09:06:11 INFO - PROCESS | 29030 | 09:06:11 INFO - PROCESS | 29030 | [#5] yui.html Cycles:180 Average:16248.13 Median:488.79 stddev:22269.17 (4556.0%) stddev-sans-first:22300.79 09:06:11 INFO - PROCESS | 29030 | Values: 636.4 641.9 644.6 707.9 732.7 12242.2 12702.1 12722.9 12726.6 12734.6 13190.8 13274.3 13298.6 13305.1 13366.1 595.7 716.5 718.7 746.1 746.3 740.3 745.7 745.7 746.0 746.1 786.2 787.4 787.6 787.7 787.8 621.6 637.8 638.3 639.6 789.0 559.1 574.2 579.5 579.7 579.7 12898.8 12923.7 12943.4 12947.9 12952.0 11368.8 11620.9 11712.3 11953.3 12186.2 11702.3 11819.6 11898.0 11925.5 12275.4 3859.4 3873.4 3906.9 4011.3 4056.8 64551.4 66900.7 66982.0 67036.3 67064.3 8628.8 9103.4 9231.4 9311.0 10186.3 18459.4 18787.0 18813.5 18815.2 18844.7 6605.4 6611.4 6621.3 6842.6 6858.7 3501.9 3506.6 3507.7 3596.2 3687.2 2622.1 2724.7 2732.9 2733.8 2734.6 464.9 471.6 478.4 479.8 485.3 405.1 414.9 427.9 443.6 457.9 6545.2 6615.9 6801.9 7064.1 7122.8 391.6 430.8 492.3 508.0 513.5 3334.5 3461.2 3480.4 3508.4 3615.3 53439.5 53560.0 53708.7 75792.0 79932.6 76880.2 77914.6 78739.6 78804.6 79499.2 65378.7 69899.7 71273.3 73358.3 73401.6 7862.1 7870.5 7919.7 7946.9 8084.8 42295.8 42616.0 42798.8 43314.1 44465.1 54443.5 57057.4 58491.7 60817.4 64341.7 9998.5 10394.4 10423.6 10511.9 10523.2 10746.7 11156.4 11411.9 11632.6 12122.6 9998.0 10195.9 10248.8 10862.1 11061.5 10333.4 10848.0 10916.2 10930.0 11160.1 10130.4 10256.9 10614.4 11099.6 11137.7 9047.6 9291.7 9524.6 9596.3 9729.5 9215.7 9585.9 9593.5 9618.6 9673.5 09:06:11 INFO - PROCESS | 29030 | -------- Summary: end -------- 09:06:11 INFO - PROCESS | 29030 | 09:06:12 INFO - TEST-INFO | 29030: exit 0 09:06:12 INFO - TEST-OK | dromaeo_css | took 1121080ms 09:06:12 INFO - TEST-START | kraken 09:06:12 INFO - operating with platform_type : linux_ 09:06:12 INFO - Initialising browser for kraken test... 09:06:12 INFO - TEST-INFO | started process 29334 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgSVmsc/profile http://localhost:33807/getInfo.html) 09:06:17 INFO - PROCESS | 29334 | __metrics Screen width/height:1600/1200 09:06:17 INFO - PROCESS | 29334 | colorDepth:24 09:06:17 INFO - PROCESS | 29334 | Browser inner width/height: 1024/697 09:06:17 INFO - PROCESS | 29334 | __metrics 09:06:17 INFO - PROCESS | 29334 | 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:06:17 INFO - PROCESS | 29334 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:06:18 INFO - PROCESS | 29334 | console.error: PushService: 09:06:18 INFO - PROCESS | 29334 | stateChangeProcessEnqueue: Error transitioning state 09:06:18 INFO - PROCESS | 29334 | UnknownError 09:06:19 INFO - TEST-INFO | 29334: exit 0 09:06:19 INFO - Browser initialized. 09:06:19 INFO - Running cycle 1/1 for kraken test... 09:06:19 INFO - TEST-INFO | started process 29413 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgSVmsc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:06:31 INFO - PROCESS | 29413 | RSS: Main: 182362112 09:06:31 INFO - PROCESS | 29413 | 09:06:34 INFO - PROCESS | 29413 | Cycle 1(1): loaded http://localhost:33807/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33807/tests/kraken/driver.html?testName=audio-beat-detection) 09:06:34 INFO - PROCESS | 29413 | RSS: Main: 239161344 09:06:34 INFO - PROCESS | 29413 | 09:06:37 INFO - PROCESS | 29413 | Cycle 1(1): loaded http://localhost:33807/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33807/tests/kraken/driver.html?testName=audio-dft) 09:06:38 INFO - PROCESS | 29413 | RSS: Main: 225640448 09:06:38 INFO - PROCESS | 29413 | 09:06:41 INFO - PROCESS | 29413 | Cycle 1(1): loaded http://localhost:33807/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33807/tests/kraken/driver.html?testName=audio-fft) 09:06:42 INFO - PROCESS | 29413 | RSS: Main: 302915584 09:06:42 INFO - PROCESS | 29413 | 09:06:44 INFO - PROCESS | 29413 | Cycle 1(1): loaded http://localhost:33807/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33807/tests/kraken/driver.html?testName=audio-oscillator) 09:06:44 INFO - PROCESS | 29413 | RSS: Main: 213397504 09:06:44 INFO - PROCESS | 29413 | 09:06:47 INFO - PROCESS | 29413 | Cycle 1(1): loaded http://localhost:33807/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33807/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:06:47 INFO - PROCESS | 29413 | RSS: Main: 215334912 09:06:47 INFO - PROCESS | 29413 | 09:06:50 INFO - PROCESS | 29413 | Cycle 1(1): loaded http://localhost:33807/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33807/tests/kraken/driver.html?testName=imaging-darkroom) 09:06:51 INFO - PROCESS | 29413 | RSS: Main: 253317120 09:06:51 INFO - PROCESS | 29413 | 09:06:55 INFO - PROCESS | 29413 | Cycle 1(1): loaded http://localhost:33807/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33807/tests/kraken/driver.html?testName=imaging-desaturate) 09:06:55 INFO - PROCESS | 29413 | RSS: Main: 247398400 09:06:55 INFO - PROCESS | 29413 | 09:06:58 INFO - PROCESS | 29413 | Cycle 1(1): loaded http://localhost:33807/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33807/tests/kraken/driver.html?testName=json-parse-financial) 09:06:59 INFO - PROCESS | 29413 | RSS: Main: 250245120 09:06:59 INFO - PROCESS | 29413 | 09:07:00 INFO - PROCESS | 29413 | Cycle 1(1): loaded http://localhost:33807/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33807/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:07:01 INFO - PROCESS | 29413 | RSS: Main: 214482944 09:07:01 INFO - PROCESS | 29413 | 09:07:03 INFO - PROCESS | 29413 | Cycle 1(1): loaded http://localhost:33807/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33807/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:07:04 INFO - PROCESS | 29413 | RSS: Main: 221356032 09:07:04 INFO - PROCESS | 29413 | 09:07:06 INFO - PROCESS | 29413 | Cycle 1(1): loaded http://localhost:33807/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33807/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:07:07 INFO - PROCESS | 29413 | RSS: Main: 222568448 09:07:07 INFO - PROCESS | 29413 | 09:07:09 INFO - PROCESS | 29413 | Cycle 1(1): loaded http://localhost:33807/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33807/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:07:10 INFO - PROCESS | 29413 | RSS: Main: 223735808 09:07:10 INFO - PROCESS | 29413 | 09:07:13 INFO - PROCESS | 29413 | Cycle 1(1): loaded http://localhost:33807/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33807/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:07:14 INFO - PROCESS | 29413 | RSS: Main: 221724672 09:07:14 INFO - PROCESS | 29413 | 09:07:15 INFO - PROCESS | 29413 | Cycle 1(1): loaded http://localhost:33807/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33807/tests/kraken/driver.html?testName=ai-astar) 09:07:16 INFO - PROCESS | 29413 | RSS: Main: 272351232 09:07:16 INFO - PROCESS | 29413 | 09:07:16 INFO - PROCESS | 29413 | __start_tp_report 09:07:16 INFO - PROCESS | 29413 | _x_x_mozilla_page_load 09:07:16 INFO - PROCESS | 29413 | _x_x_mozilla_page_load_details 09:07:16 INFO - PROCESS | 29413 | |i|pagename|runs| 09:07:16 INFO - PROCESS | 29413 | |0;ai-astar;114;117;133;114;115;114;112;113;113;113 09:07:16 INFO - PROCESS | 29413 | |1;audio-beat-detection;147;123;158;189;122;150;146;124;178;122 09:07:16 INFO - PROCESS | 29413 | |2;audio-dft;161;162;162;161;163;164;162;163;161;163 09:07:16 INFO - PROCESS | 29413 | |3;audio-fft;76;76;75;165;77;76;76;77;162;76 09:07:16 INFO - PROCESS | 29413 | |4;audio-oscillator;83;84;137;82;83;83;145;83;83;143 09:07:16 INFO - PROCESS | 29413 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 09:07:16 INFO - PROCESS | 29413 | |6;imaging-darkroom;147;147;147;147;147;148;148;147;147;148 09:07:16 INFO - PROCESS | 29413 | |7;imaging-desaturate;96;96;96;96;96;96;96;95;96;95 09:07:16 INFO - PROCESS | 29413 | |8;json-parse-financial;65;62;64;64;65;64;65;66;64;64 09:07:16 INFO - PROCESS | 29413 | |9;json-stringify-tinderbox;65;66;65;66;67;65;69;66;66;66 09:07:16 INFO - PROCESS | 29413 | |10;stanford-crypto-aes;82;82;94;91;89;86;83;83;80;82 09:07:16 INFO - PROCESS | 29413 | |11;stanford-crypto-ccm;137;131;150;133;140;134;146;140;174;140 09:07:16 INFO - PROCESS | 29413 | |12;stanford-crypto-pbkdf2;174;175;175;174;176;175;173;176;176;176 09:07:16 INFO - PROCESS | 29413 | |13;stanford-crypto-sha256-iterative;69;75;71;69;68;69;70;68;70;68 09:07:16 INFO - PROCESS | 29413 | __end_tp_report 09:07:16 INFO - PROCESS | 29413 | __start_cc_report 09:07:16 INFO - PROCESS | 29413 | _x_x_mozilla_cycle_collect,2037 09:07:16 INFO - PROCESS | 29413 | __end_cc_report 09:07:16 INFO - PROCESS | 29413 | __startTimestamp1472573236092__endTimestamp 09:07:16 INFO - PROCESS | 29413 | 09:07:16 INFO - PROCESS | 29413 | ------- Summary: start ------- 09:07:16 INFO - PROCESS | 29413 | Number of tests: 14 09:07:16 INFO - PROCESS | 29413 | 09:07:16 INFO - PROCESS | 29413 | [#0] ai-astar Cycles:10 Average:115.80 Median:114.00 stddev:6.20 (5.4%) stddev-sans-first:6.54 09:07:16 INFO - PROCESS | 29413 | Values: 114.0 117.0 133.0 114.0 115.0 114.0 112.0 113.0 113.0 113.0 09:07:16 INFO - PROCESS | 29413 | 09:07:16 INFO - PROCESS | 29413 | [#1] audio-beat-detection Cycles:10 Average:145.90 Median:148.50 stddev:24.03 (16.2%) stddev-sans-first:25.49 09:07:16 INFO - PROCESS | 29413 | Values: 147.0 123.0 158.0 189.0 122.0 150.0 146.0 124.0 178.0 122.0 09:07:16 INFO - PROCESS | 29413 | 09:07:16 INFO - PROCESS | 29413 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.50 stddev:1.03 (0.6%) stddev-sans-first:1.00 09:07:16 INFO - PROCESS | 29413 | Values: 161.0 162.0 162.0 161.0 163.0 164.0 162.0 163.0 161.0 163.0 09:07:16 INFO - PROCESS | 29413 | 09:07:16 INFO - PROCESS | 29413 | [#3] audio-fft Cycles:10 Average:93.60 Median:76.00 stddev:36.85 (48.5%) stddev-sans-first:38.53 09:07:16 INFO - PROCESS | 29413 | Values: 76.0 76.0 75.0 165.0 77.0 76.0 76.0 77.0 162.0 76.0 09:07:16 INFO - PROCESS | 29413 | 09:07:16 INFO - PROCESS | 29413 | [#4] audio-oscillator Cycles:10 Average:100.60 Median:83.00 stddev:28.41 (34.2%) stddev-sans-first:29.41 09:07:16 INFO - PROCESS | 29413 | Values: 83.0 84.0 137.0 82.0 83.0 83.0 145.0 83.0 83.0 143.0 09:07:16 INFO - PROCESS | 29413 | 09:07:16 INFO - PROCESS | 29413 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 09:07:16 INFO - PROCESS | 29413 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 09:07:16 INFO - PROCESS | 29413 | 09:07:16 INFO - PROCESS | 29413 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 09:07:16 INFO - PROCESS | 29413 | Values: 147.0 147.0 147.0 147.0 147.0 148.0 148.0 147.0 147.0 148.0 09:07:16 INFO - PROCESS | 29413 | 09:07:16 INFO - PROCESS | 29413 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:07:16 INFO - PROCESS | 29413 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 95.0 09:07:16 INFO - PROCESS | 29413 | 09:07:16 INFO - PROCESS | 29413 | [#8] json-parse-financial Cycles:10 Average:64.30 Median:64.50 stddev:1.06 (1.6%) stddev-sans-first:1.09 09:07:16 INFO - PROCESS | 29413 | Values: 65.0 62.0 64.0 64.0 65.0 64.0 65.0 66.0 64.0 64.0 09:07:16 INFO - PROCESS | 29413 | 09:07:16 INFO - PROCESS | 29413 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.00 stddev:1.20 (1.8%) stddev-sans-first:1.20 09:07:16 INFO - PROCESS | 29413 | Values: 65.0 66.0 65.0 66.0 67.0 65.0 69.0 66.0 66.0 66.0 09:07:16 INFO - PROCESS | 29413 | 09:07:16 INFO - PROCESS | 29413 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:84.50 stddev:4.64 (5.5%) stddev-sans-first:4.77 09:07:16 INFO - PROCESS | 29413 | Values: 82.0 82.0 94.0 91.0 89.0 86.0 83.0 83.0 80.0 82.0 09:07:16 INFO - PROCESS | 29413 | 09:07:16 INFO - PROCESS | 29413 | [#11] stanford-crypto-ccm Cycles:10 Average:142.50 Median:140.00 stddev:12.49 (8.9%) stddev-sans-first:13.09 09:07:16 INFO - PROCESS | 29413 | Values: 137.0 131.0 150.0 133.0 140.0 134.0 146.0 140.0 174.0 140.0 09:07:16 INFO - PROCESS | 29413 | 09:07:16 INFO - PROCESS | 29413 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.00 Median:175.50 stddev:1.05 (0.6%) stddev-sans-first:1.05 09:07:16 INFO - PROCESS | 29413 | Values: 174.0 175.0 175.0 174.0 176.0 175.0 173.0 176.0 176.0 176.0 09:07:16 INFO - PROCESS | 29413 | 09:07:16 INFO - PROCESS | 29413 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:69.50 stddev:2.11 (3.0%) stddev-sans-first:2.22 09:07:16 INFO - PROCESS | 29413 | Values: 69.0 75.0 71.0 69.0 68.0 69.0 70.0 68.0 70.0 68.0 09:07:16 INFO - PROCESS | 29413 | -------- Summary: end -------- 09:07:16 INFO - PROCESS | 29413 | 09:07:17 INFO - TEST-INFO | 29413: exit 0 09:07:17 INFO - TEST-OK | kraken | took 64449ms 09:07:17 INFO - SUITE-END | took 1185s 09:07:17 INFO - Completed test suite (00:19:45) 09:07:17 INFO - javascript benchmark 09:07:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2561.628563858241, 2577.7164511903698, 2586.767190952814, 2597.298729343077, 2610.765031147196, 4453.398791163192, 4518.954810451894, 4522.841700540482, 4549.863504094882, 4609.769511524423, 4513.796879140438, 4562.1788078146, 4571.497135315112, 4574.97712511437, 4589.632829373651, 4258.680598955075, 4260.531341552427, 4280.464941882265, 4295.871123866274, 4348.086901750637, 4143.606357396043, 4283.057727300004, 4301.6988810783105, 4307.5261721210645, 4351.630111440531, 4288.592583704543, 4331.43691320128, 4357.085012147453, 4357.869263922087, 4359.738415695053, 4143.109231515239, 4186.0, 4257.936130958038, 4292.484901811787, 4308.224519586473, 4118.279301122321, 4156.792160391999, 4162.0, 4163.063310755087, 4173.10278290169, 4499.75251361175, 4572.199865023607, 4575.084983003379, 4583.289590113538, 4587.1513769952335, 4767.785449654774, 4825.179719447702, 4887.853364399074, 4897.4857639948, 4941.135301322254, 4855.077535268288, 4883.8779030524165, 4890.437599676047, 4895.5838753705975, 4908.975455122737, 4574.794134263966, 4576.290674945389, 4583.197940360424, 4593.26507758757, 4638.0, 4896.143174944442, 4940.975295123501, 4985.177445721488, 5008.524190201925, 5016.648834581617, 4792.065547218329, 4798.304245884327, 4862.05189987949, 4868.075065737498, 4877.829275975324, 4873.463918968911, 4889.022195560902, 4889.682170658896, 4890.095332363524, 4948.38145231846, 4848.393950756155, 4856.125897338442, 4857.2228443449585, 4862.635302352338, 4909.4354149273295, 4726.196546587088, 4784.856454306377, 4791.401074865642, 4839.225723884232, 4840.056189043174, 4107.958920410817, 4142.047329114261, 4147.419361289422, 4147.771872547039, 4147.958520414757, 3608.8376023079027, 3645.76302540334, 3702.4816525686424, 3708.1100535871196, 3708.2398108387715, 4251.043515209115, 4252.022034931983, 4291.892702682458, 4296.312589985588, 4310.849120280775, 4855.927161092586, 4864.73243971585, 4889.706617602955, 4900.362952816183, 4947.25791131326, 4161.687873409506, 4212.894677633084, 4238.618524332764, 4253.3619957006695, 4301.78491075445, 4390.209762242763, 4413.889652758642, 4418.977905110518, 4463.464384273908, 4472.351509031172, 4646.210144275414, 4646.790894409692, 4650.767461626838, 4706.294055891575, 4728.290756386569, 4774.045190961752, 4807.6394270429155, 4914.041761856403, 4922.089413458379, 4929.753512324298, 4616.584507394351, 4631.698939568917, 4634.4670362907345, 4688.695234809727, 4697.0840686065885, 4817.349657796293, 4817.397825271841, 4824.589909857561, 4829.468758436499, 4886.87601851569, 4714.693544919569, 4836.250381190921, 4864.175640272169, 4882.414110306786, 4937.802487900443, 4755.714657120584, 4758.643101767312, 4776.832810851603, 4834.299026641188, 4836.637252206169, 4765.785539650655, 4769.856904292877, 4776.856694299037, 4777.665563410528, 4834.758262086812, 4586.610138138162, 4686.953130468788, 4706.527154957648, 4723.409573803275, 4754.928676069792, 4771.451283102488, 4785.832495862628, 4810.927836082392, 4853.441854186673, 4867.245576935581, 4688.296755486705, 4709.693869898446, 4716.551927566876, 4733.597644200281, 4773.71357718538], "value": 4504.938911211156, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.1825806934771, 555.4584280326682, 560.7252446301313, 561.7444062951357, 569.4504802865234, 37895.43156852646, 39915.60084399155, 39954.80022599883, 40061.599384006186, 43496.782516087376, 39908.201835963264, 40388.79805600975, 40490.19019619606, 40497.392539111934, 40781.796091019576, 7641.61791910405, 7779.183185765498, 7782.105057918327, 7791.493552919071, 7795.18150594188, 7623.0, 7670.041244844395, 7696.461247712662, 7697.538147711127, 7709.0, 7749.612519374037, 7775.6500957456765, 7780.961095194516, 7783.299503044725, 7784.0, 7648.196939321402, 7684.193159718233, 7708.845823083563, 7725.690972361099, 7734.5359278443475, 7482.401407887356, 7549.7357592483995, 7550.207228241011, 7554.0, 7572.129205141369, 37914.24171516554, 38373.0, 38377.808110959544, 38379.8081009596, 38397.200349956256, 2841.687414384416, 3015.532592448152, 3114.98442507786, 3343.7325013999066, 3383.2387712764676, 28433.3085040968, 28511.714882851113, 28554.571681424586, 28578.0, 29070.854645726635, 3498.2828520153307, 3520.260745243502, 3564.0, 3601.243738814852, 3730.981345093257, 241142.0, 241631.0, 241635.0, 242286.0, 242998.0, 31958.36083278368, 33127.33745325128, 51348.0, 51550.22674659883, 51727.48272517227, 32883.34233315368, 33066.504002439986, 33153.33693326168, 33166.66833331636, 33197.668023319944, 11474.655760327203, 11476.54093836254, 11521.07831373488, 11521.193516453935, 11578.421078946187, 9633.421994680342, 9680.903190968, 9693.41839489633, 9695.418274903528, 9704.75738106553, 7653.502522336031, 7698.230176982257, 7707.383409327241, 7711.113221979432, 7785.455018148676, 3009.5485677148167, 3022.3199780049313, 3053.5114381698822, 3065.1417603071177, 3071.616047994001, 803.5580430763057, 804.6137853830194, 850.4854562989426, 866.8049688819965, 879.090141703334, 26286.47427051448, 26876.59685104725, 27161.320966975985, 27375.315617109733, 27481.0, 726.8800647893144, 830.9002919649681, 846.2933450568721, 874.2874557235832, 923.4966943016072, 12995.28525931064, 14095.929520352332, 14108.15351078918, 14131.929340353438, 14222.502212422516, 370878.0, 371060.0, 373482.0, 375090.0, 375217.0, 47301.52698472971, 47856.282155767694, 47891.521084789405, 47995.280070798966, 48076.0, 941.087145468894, 1081.9621313254, 1087.141158484788, 1105.701460605632, 1112.3548341961805, 26932.865335673196, 27873.58189627198, 29192.31189905578, 29213.415731685673, 29533.0, 40920.386194207706, 41382.79308603438, 41432.0, 41456.0, 41474.79262603788, 235133.0, 235242.0, 235313.0, 235902.0, 236126.0, 21575.46061348479, 22040.0, 22227.999740012063, 22269.220577279717, 22318.776812232318, 37876.62123378731, 38524.0, 40508.0, 41170.0, 42002.57997419986, 34154.82922585371, 34251.486227706104, 34265.0, 34292.31415371629, 34407.65592344045, 33108.503372449915, 34854.65145348514, 34867.65132348746, 35084.29831403409, 35248.823755882084, 34441.48337774986, 34963.951081467596, 35448.645513544536, 35653.28693426169, 35724.10689732777, 30228.546571801002, 32431.837840810644, 32439.351212976082, 32561.511577325884, 32922.67077329196, 23827.629911280128, 24294.757052429955, 24533.157439749408, 24854.378640533407, 24974.250772476855], "value": 15706.100710896228, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.8467347356953, 355.84342889128783, 360.4035321542847, 363.4439307858975, 381.5769861380236, 12599.874001259985, 15005.024673396236, 16208.108554029524, 16278.593035174126, 16384.18079096045, 14836.703265934675, 15264.465743698973, 15371.385144594231, 15463.922680386582, 15577.221138943065, 5035.194368900977, 5061.0, 5256.632035757499, 5276.894462110756, 5277.234800953859, 3722.274156539476, 5162.896742065156, 5250.343707036621, 5893.941060589382, 6198.628082315053, 6156.998975333012, 6158.476529494998, 6162.969185154068, 6164.075388691687, 6171.0, 5949.048152295633, 6035.6680382578725, 6093.238345206849, 6105.9694701526205, 6110.572259941806, 5082.440931497532, 5313.256144139824, 5321.813736519242, 5323.068463018956, 5327.147656374961, 20008.799032106457, 20290.898545507327, 20298.797012029987, 20616.793832061787, 20640.69038964417, 1605.6226786705115, 1687.2070127040272, 1776.9555761105946, 1860.4046705054388, 2546.4907018596355, 8782.60478278479, 9196.448213107167, 9359.20446762026, 9574.90425095747, 9663.130318271318, 1737.8435940765266, 1752.2027477497836, 1764.1267572551542, 1790.883592566479, 1802.8918264904148, 63583.68208158976, 66569.0, 67631.0, 69242.0, 69510.30489695088, 9512.191463725661, 9721.756956076155, 9752.171065459373, 9804.754881128029, 9805.705828825146, 12653.557125500563, 12654.114212005255, 12732.936335318263, 12739.808902866464, 12760.106792524433, 6863.38229559342, 6923.6192009439965, 7057.329553692391, 7089.964550177217, 7099.858002839915, 6337.524685648595, 6377.139086223393, 6390.0734393512685, 6551.050097735897, 6605.306442823435, 3704.2591481703766, 3733.8506459741848, 4009.1981603679383, 4182.749035057906, 4203.495580530356, 1766.1169415292354, 1786.2497750944635, 1800.207908520247, 1804.440623406748, 1818.4362847517311, 755.5617741709796, 771.028504084846, 778.9961050194826, 813.4143416739938, 819.2053707903324, 15913.602159946095, 16448.506544803677, 16836.24236909342, 17291.91354043222, 17517.38689145899, 745.671904362079, 815.657423881971, 831.7089018843477, 848.5672307123411, 872.8908886389202, 9073.59168837404, 9122.771930701785, 9347.626094956126, 9353.859692104625, 9588.904110958802, 276270.0, 281796.0, 353312.0, 355882.0, 356506.0, 46723.29915051277, 54033.45966540284, 60352.698236508535, 65652.0, 70156.0, 912.8767616371838, 924.0666926404245, 931.7158266728577, 944.9291303152291, 992.5087081894509, 14851.108933464027, 15244.542663720105, 15427.84572154264, 15569.532914012598, 15999.760003599722, 25214.991400344516, 28922.132336029954, 37314.62685373111, 37844.243115138095, 38114.0, 49666.75166624288, 50116.49883501118, 50318.0, 50515.747421262655, 50742.492575073775, 7217.24218957002, 7429.0, 7590.620468976639, 7632.0, 7816.4137689674635, 8421.410501264852, 11291.43542822872, 11432.542698292307, 11671.474783634587, 11691.707707307045, 10011.348127559162, 10215.94892025535, 10266.845997309896, 10291.897081029094, 10516.947415263181, 4535.614472769851, 9449.858252126087, 10090.798184036425, 10120.190384769348, 10564.841527376942, 10231.7442063949, 10508.78982420332, 10689.786204276026, 10778.353298802096, 10794.244402891722, 7062.15254169503, 7071.43428525727, 7148.749793757193, 7308.123025237006, 7550.5469671819865, 9357.298202634693, 9614.663486777928, 9796.922338542612, 9993.550290236812, 10388.740281493023], "value": 7903.229024408316, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1304.8303720516335, 1339.1161833190097, 1380.3236414157059, 1624.5045261195346, 1663.8918470299423, 6930.480213983952, 7459.142198647157, 7469.02902622659, 7486.775396738107, 7674.2709442603, 6470.9029364559565, 7123.9287607123915, 7366.963165184166, 7400.185979542246, 7471.1408188058385, 2131.072983252286, 2153.257126291427, 2176.3144609448054, 2179.7820217978233, 2180.018991453844, 2163.8485306028583, 2201.757806641268, 2208.3043841189974, 2208.8012078912893, 2211.2039665720326, 1860.0513737993654, 2089.550746589483, 2161.373201771484, 2165.8375621828345, 2167.5339801942578, 2153.095699806085, 2156.4285464351883, 2172.5872084303933, 2176.4885251965934, 2178.880161591112, 2146.5921474919714, 2150.817180539656, 2153.569286142762, 2154.644483660194, 2155.708979287792, 7521.887171692429, 7532.13380461243, 7561.395088392916, 7564.810879727996, 7597.734079307198, 4189.560096189886, 4191.664666826647, 4236.830526778926, 4238.87283381499, 4246.745195288293, 2732.8686389499367, 2855.842928638924, 2869.110575721533, 2877.9712202877913, 2883.1494709060876, 885.7475619448426, 916.9724908252697, 934.444005816538, 949.4682977532535, 950.5484894675043, 9647.614095436174, 9703.0, 9712.174465170398, 9714.659986900424, 9747.610095596168, 3851.768893866377, 3975.940360894589, 4052.5744796796503, 4139.130782535702, 4160.375943608423, 8484.872726909101, 8518.148185181557, 8519.659213631508, 8520.147985201555, 8531.701390451304, 4235.618794308527, 4274.743515389025, 4275.0594869128745, 4279.293916503742, 4290.806913688892, 3853.5183102112237, 3879.398693202558, 3884.126071633916, 3885.805709714503, 3910.178862438863, 3213.5983002124735, 3345.5985281766343, 3368.949465758016, 3375.4599264117624, 3420.572428446444, 1019.5513973851481, 1033.9896601034043, 1045.6497073480468, 1048.8269435543202, 1052.6894566103017, 633.4014356433127, 657.81252343082, 685.5441131647399, 688.5834070387443, 792.5482474989316, 4617.607503362252, 4715.481297057321, 4755.714657120584, 4768.1417344878255, 4901.852944411602, 734.2363941500779, 774.3340726974798, 781.8788087846393, 790.8457850719169, 819.5451524404014, 3136.0, 3215.951760723591, 3260.396826587089, 3278.770486066, 3379.3579219948133, 8801.779955501164, 8805.69180078694, 8827.602757875911, 8952.507612081397, 9207.539623018822, 8771.824563508693, 8785.428947118417, 8800.119988001277, 8809.603567839462, 8827.823443531093, 6852.931470685329, 6972.442204623618, 6980.813261745516, 6984.02223688684, 6993.160820701447, 4686.133065382915, 4692.9530704692515, 4736.076465089274, 4793.23308270675, 4804.495527969513, 8232.135625759209, 8295.668173273001, 8308.958455207685, 8338.62476188585, 8342.624581893708, 8372.413931025014, 8544.572771361283, 8631.0, 8642.135786421308, 8643.913560864563, 6080.391960803884, 6335.556511044183, 6372.58578192416, 6503.154589903283, 6509.674516274262, 6989.231184569591, 7031.472639551952, 7034.718611255493, 7046.436285097282, 7050.858982820418, 6141.447269745744, 6173.6913154343, 6175.320714721467, 6177.4749146323065, 6321.051842223519, 5949.791757288474, 6050.788222412194, 6145.508359331154, 6261.843453913689, 6335.3981371769605, 5645.830625081254, 5740.712964351682, 5752.741126649227, 5753.05074662676, 5753.942460575341, 4017.5178978522763, 4036.5156181258435, 4096.32410652239, 4112.259793237126, 4223.113146239324, 4119.732217405859, 4178.561251068716, 4317.201317756225, 4346.934795978, 4348.565143485626], "value": 3876.767982279362, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.30713672911565, 298.75352833912024, 304.451986424436, 304.6603037613061, 307.7953161147837, 4645.976770116153, 4710.880103953226, 4761.523847615237, 4806.923568915888, 4819.807207711691, 4531.071130418264, 4659.231226847566, 4696.624270058395, 4698.483166851644, 4712.0, 3761.1913438610695, 3761.755485893422, 3766.133789228479, 3768.8869333920024, 3775.5658099318584, 3552.573691157052, 3622.7826330420257, 3758.2859256741267, 3787.3182827091114, 3790.223004284129, 3718.4980027696183, 3722.776633401991, 3723.7951912644794, 3729.1236559408517, 3732.701383889282, 3712.7029837612927, 3724.9255014899823, 3730.8694195703292, 3738.5700644425965, 3738.8504459821575, 3270.7546933980047, 3271.689189527015, 3272.4436845736045, 3280.442324804765, 3299.538064670948, 4494.628370971286, 4628.81965098901, 4673.182193116191, 4679.766011699436, 4682.1103990241745, 4278.251306021434, 4280.978595107035, 4283.657307415399, 4302.41917341158, 4308.879691280258, 4990.525900039491, 5058.570021548173, 5059.696418214919, 5063.569596584295, 5064.468230835746, 3389.711874490671, 3556.7551357024836, 3687.539057617798, 3694.5751238607636, 3696.537932758405, 5180.766865491062, 5193.870153246161, 5195.402528709171, 5200.29795977542, 5202.245674377232, 3636.5999740028574, 3637.217998130415, 3637.4543818427446, 3637.745357824927, 3639.454081887685, 3692.280005398975, 3693.759905606181, 3693.8891833245048, 3720.3675375186285, 3734.421164719473, 4026.0, 4193.20329137469, 4204.873853784391, 4227.302495088337, 4261.147770445923, 4995.17579599362, 4998.625103117281, 5002.52476014778, 5006.974965125224, 5016.347874776256, 1205.1142410328403, 1242.6082787278126, 1258.8426446694164, 1265.0, 1273.4333221716247, 856.5674334461057, 857.5455008845322, 869.2350731356366, 876.5003947749722, 881.8192270584515, 4373.66603186025, 4378.277584198571, 4390.165868484977, 4411.18393097278, 4415.933760993587, 5050.535344749981, 5054.494550544916, 5083.881546059861, 5087.26234695967, 5100.183970564692, 4362.956370436255, 4363.912721745611, 4384.758838263926, 4391.67062470316, 4415.161119387306, 2293.8508996915148, 2370.7510711375057, 2396.496735685491, 2400.1039179048357, 2401.3876461502205, 4293.141371725605, 4311.805968731414, 4337.82648694055, 4353.0, 4359.956400435955, 4609.124266389375, 4629.213033784265, 4648.535711251013, 4648.790804413742, 4662.953370466252, 4153.418521407006, 4285.871423857289, 4293.463317085364, 4324.113751460829, 4329.437173167531, 4474.0, 4491.529658687774, 4500.684952053325, 4516.435445569304, 4522.773861306856, 4419.447569053868, 4452.755098469615, 4471.239889218776, 4471.28459446487, 4476.664250181184, 4181.18118618402, 4267.930053923907, 4277.401163837128, 4322.622557593374, 4338.6312163466455, 3337.6803121831067, 3341.682540158681, 3343.3313337333116, 3360.428727116347, 3371.7524515929263, 4521.886952826206, 4526.2305408081365, 4547.6584407599175, 4557.293619488984, 4832.767644250694, 4746.216874215854, 4977.527134922177, 5003.373229054775, 5012.967154871396, 5028.572571331331, 5008.323876276656, 5023.095842748195, 5023.120953833138, 5035.29505869186, 5046.646734728533, 4816.386510518875, 4962.841164093631, 4975.925361119658, 4979.356812252021, 4987.177115775857, 5044.385796545071, 5047.798088076436, 5061.190209566452, 5063.873403164803, 5074.695518268915, 4880.267959805916, 4924.950750492592, 4929.8907745756915, 4946.925796112989, 4968.627352948615], "value": 3662.2331732263488, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [636.3922454056379, 641.9133416988706, 644.6067898581865, 707.9327463890932, 732.7435397610835, 12242.204256723307, 12702.110852240347, 12722.872771272285, 12726.618201453959, 12734.617961461148, 13190.802137967914, 13274.269915154662, 13298.601041968732, 13305.13516621419, 13366.131201471897, 595.6991719181829, 716.4554938246931, 718.6550455781228, 746.0525133080984, 746.3394895517479, 740.2597402597403, 745.6905384265523, 745.697992313114, 746.0450623202282, 746.0860445953717, 786.2098590916121, 787.4251796188786, 787.6337503061076, 787.6967367563471, 787.8069872881152, 621.5928566788738, 637.7799659117597, 638.2532437048618, 639.587466084373, 789.0, 559.0942672869977, 574.22192928582, 579.5161040531161, 579.6927628356977, 579.7043507811004, 12898.80651790224, 12923.741525169538, 12943.417546210443, 12947.87052129476, 12952.028597855198, 11368.772624547546, 11620.883791162149, 11712.297262164297, 11953.342566158857, 12186.2078964867, 11702.2978621283, 11819.645410637695, 11898.0, 11925.522979080914, 12275.386230688518, 3859.363205071188, 3873.4383514390256, 3906.8632597858937, 4011.29802284599, 4056.7565946043037, 64551.35448645547, 66900.6654966727, 66982.0, 67036.3296367035, 67064.3293567063, 8628.827423451496, 9103.408278462011, 9231.399959002643, 9311.0, 10186.286959912735, 18459.353922612645, 18787.0, 18813.529661758566, 18815.153318100718, 18844.717329240073, 6605.393193568751, 6611.404973552307, 6621.33786621334, 6842.589444633239, 6858.725650973905, 3501.9474707879403, 3506.561679790026, 3507.6667716567395, 3596.2268112355446, 3687.1703866629796, 2622.10848311575, 2724.6594175728032, 2732.904348347838, 2733.8223015503927, 2734.5624700047897, 464.8698364457957, 471.5543811098479, 478.4450037955954, 479.8368554691352, 485.31812803011826, 405.1047185719534, 414.91909077730156, 427.9486461624625, 443.58303194996597, 457.9450465944108, 6545.247296560957, 6615.933840661628, 6801.931980680229, 7064.081669382947, 7122.7507037253445, 391.63773509504165, 430.84318604546894, 492.2591499792789, 507.974601269935, 513.4557369188672, 3334.4664853623303, 3461.238527523941, 3480.390931587013, 3508.3509550733197, 3615.3492371373404, 53439.46560534422, 53560.0, 53708.731456342466, 75792.0, 79932.60033699794, 76880.23119768842, 77914.6104269475, 78739.60630196812, 78804.60597696975, 79499.20500795034, 65378.67310663416, 69899.66053564302, 71273.28726712667, 73358.26641733514, 73401.6329918347, 7862.135165131716, 7870.488418252795, 7919.722809701633, 7946.920530794618, 8084.83830323402, 42295.7885210572, 42616.0, 42798.78600606977, 43314.133717326105, 44465.11069778522, 54443.45556544384, 57057.42942570687, 58491.70754146202, 60817.391826082945, 64341.678291608245, 9998.500074996076, 10394.376337419477, 10423.583056677648, 10511.94744026275, 10523.210759193244, 10746.660958477918, 11156.44217789091, 11411.942940285246, 11632.592859249886, 12122.575709850113, 9998.0, 10195.949020254851, 10248.846267305848, 10862.125405469475, 11061.5022323994, 10333.431661258703, 10848.0, 10916.235863489797, 10930.0, 11160.051395631463, 10130.392176469435, 10256.948715256376, 10614.363138211733, 11099.557057582462, 11137.665870023913, 9047.638094476148, 9291.72124836256, 9524.571394287135, 9596.328257021942, 9729.4648794317, 9215.723528294162, 9585.856212156683, 9593.472359020321, 9618.615255389706, 9673.516324183622], "value": 6111.647051644758, "unit": "score"}], "name": "dromaeo_css", "value": 6039.451818438033, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 117.0, 133.0, 114.0, 115.0, 114.0, 112.0, 113.0, 113.0, 113.0], "value": 115.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 123.0, 158.0, 189.0, 122.0, 150.0, 146.0, 124.0, 178.0, 122.0], "value": 145.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 161.0, 163.0, 164.0, 162.0, 163.0, 161.0, 163.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 165.0, 77.0, 76.0, 76.0, 77.0, 162.0, 76.0], "value": 93.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 137.0, 82.0, 83.0, 83.0, 145.0, 83.0, 83.0, 143.0], "value": 100.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 148.0, 147.0, 147.0, 148.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 64.0, 64.0, 65.0, 64.0, 65.0, 66.0, 64.0, 64.0], "value": 64.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 66.0, 67.0, 65.0, 69.0, 66.0, 66.0, 66.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 94.0, 91.0, 89.0, 86.0, 83.0, 83.0, 80.0, 82.0], "value": 85.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 131.0, 150.0, 133.0, 140.0, 134.0, 146.0, 140.0, 174.0, 140.0], "value": 142.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 175.0, 175.0, 174.0, 176.0, 175.0, 173.0, 176.0, 176.0, 176.0], "value": 175.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 75.0, 71.0, 69.0, 68.0, 69.0, 70.0, 68.0, 70.0, 68.0], "value": 69.7, "unit": "score"}], "name": "kraken", "value": 1581.0, "alertThreshold": 2.0}]} 09:07:17 INFO - Return code: 0 09:07:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:07:17 INFO - # TBPL SUCCESS # 09:07:17 INFO - Running post-action listener: _resource_record_post_action 09:07:17 INFO - [mozharness: 2016-08-30 16:07:17.871522Z] Finished run-tests step (success) 09:07:17 INFO - Running post-run listener: _resource_record_post_run 09:07:17 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 16384; Write bytes: 407769088; Read time: 332; Write time: 271888 09:07:17 INFO - TinderboxPrint: CPU usage
13.1% 09:07:17 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 332 09:07:17 INFO - TinderboxPrint: I/O write bytes / time
407,769,088 / 271,888 09:07:17 INFO - TinderboxPrint: CPU idle
8,336.4 (86.9%) 09:07:17 INFO - TinderboxPrint: CPU user
1,206.5 (12.6%) 09:07:17 INFO - TinderboxPrint: Swap in / out
0 / 0 09:07:17 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 114356224; Read time: 120; Write time: 101512 09:07:17 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 8192; Write bytes: 293412864; Read time: 196; Write time: 170376 09:07:18 INFO - Running post-run listener: _upload_blobber_files 09:07:18 INFO - Blob upload gear active. 09:07:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:07:18 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 09:07:18 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'] 09:07:18 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 09:07:18 INFO - (blobuploader) - INFO - Open directory for files ... 09:07:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:07:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:07:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:07:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:07:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:07:24 INFO - (blobuploader) - INFO - Done attempting. 09:07:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:07:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:07:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:07:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:07:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:07:25 INFO - (blobuploader) - INFO - Done attempting. 09:07:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:07:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:07:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:07:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:07:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:07:26 INFO - (blobuploader) - INFO - Done attempting. 09:07:26 INFO - (blobuploader) - INFO - Iteration through files over. 09:07:26 INFO - Return code: 0 09:07:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:07:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:07:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/49f504825bb889ea5f374bc9184602be2fef3e9e581b4671f9411c9e1e3db0a3710e19ca5d04ff11b5fea5d1fe74292908ae54517c8561f81c56863b869c8d38", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9a4e41ecefc3f305b5f18f7540bd8f7c7241a9a98c72b13a4bbbe18dbf867855aa4e0814f83d288a79f41f3d1d927bd751bffbfad6df12ff86ada0265ab56d1b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/53145357690502c43ea3edd4be6c617cca606abef1ffef428223b46a428c6ae24e5b7f41bfb514fb794c55aaa80fb741bd1face1ee0488d2f60f9fc62ce1dcbf"} 09:07:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:07:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:07:26 INFO - Contents: 09:07:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/49f504825bb889ea5f374bc9184602be2fef3e9e581b4671f9411c9e1e3db0a3710e19ca5d04ff11b5fea5d1fe74292908ae54517c8561f81c56863b869c8d38", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9a4e41ecefc3f305b5f18f7540bd8f7c7241a9a98c72b13a4bbbe18dbf867855aa4e0814f83d288a79f41f3d1d927bd751bffbfad6df12ff86ada0265ab56d1b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/53145357690502c43ea3edd4be6c617cca606abef1ffef428223b46a428c6ae24e5b7f41bfb514fb794c55aaa80fb741bd1face1ee0488d2f60f9fc62ce1dcbf"} 09:07:26 INFO - Running post-run listener: copy_logs_to_upload_dir 09:07:26 INFO - Copying logs to upload dir... 09:07:26 INFO - mkdir: /builds/slave/test/build/upload/logs 09:07:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.147179 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-08-30 09:07:26.347717) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-30 09:07:26.351632) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1472571993.445385-1117785531 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/49f504825bb889ea5f374bc9184602be2fef3e9e581b4671f9411c9e1e3db0a3710e19ca5d04ff11b5fea5d1fe74292908ae54517c8561f81c56863b869c8d38", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9a4e41ecefc3f305b5f18f7540bd8f7c7241a9a98c72b13a4bbbe18dbf867855aa4e0814f83d288a79f41f3d1d927bd751bffbfad6df12ff86ada0265ab56d1b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/53145357690502c43ea3edd4be6c617cca606abef1ffef428223b46a428c6ae24e5b7f41bfb514fb794c55aaa80fb741bd1face1ee0488d2f60f9fc62ce1dcbf"} build_url:https://queue.taskcluster.net/v1/task/XBOddpQWTCSS6QyaUAm_rw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011327 build_url: 'https://queue.taskcluster.net/v1/task/XBOddpQWTCSS6QyaUAm_rw/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/49f504825bb889ea5f374bc9184602be2fef3e9e581b4671f9411c9e1e3db0a3710e19ca5d04ff11b5fea5d1fe74292908ae54517c8561f81c56863b869c8d38", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9a4e41ecefc3f305b5f18f7540bd8f7c7241a9a98c72b13a4bbbe18dbf867855aa4e0814f83d288a79f41f3d1d927bd751bffbfad6df12ff86ada0265ab56d1b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/53145357690502c43ea3edd4be6c617cca606abef1ffef428223b46a428c6ae24e5b7f41bfb514fb794c55aaa80fb741bd1face1ee0488d2f60f9fc62ce1dcbf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-30 09:07:26.377966) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 09:07:26.378452) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1472571993.445385-1117785531 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004450 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 09:07:26.462922) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-30 09:07:26.463292) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-30 09:07:26.463629) ========= ========= Total master_lag: 0.20 =========