builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-015 starttime: 1470614235.43 results: success (0) buildid: 20160807150652 builduid: 5d0255e5fbda4650869c42fbb26aebb6 revision: 763fe887c37cee5fcfe0f00e94fdffc84a41ea1c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-07 16:57:15.425817) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-07 16:57:15.426189) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-07 16:57:15.427257) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-07 16:57:15.441564) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 16:57:15.441834) ========= 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=20e666a3d4cfbb71505a330e000001b4-1470614235.321695-453361860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-07 16:57:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-08-07 16:57:16 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.081416 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 16:57:15.537096) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 16:57:15.537379) ========= 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=20e666a3d4cfbb71505a330e000001b4-1470614235.321695-453361860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019695 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 16:57:15.588095) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 16:57:15.588488) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 763fe887c37cee5fcfe0f00e94fdffc84a41ea1c --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 763fe887c37cee5fcfe0f00e94fdffc84a41ea1c --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=20e666a3d4cfbb71505a330e000001b4-1470614235.321695-453361860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-07 16:57:16,208 truncating revision to first 12 chars 2016-08-07 16:57:16,208 Setting DEBUG logging. 2016-08-07 16:57:16,209 attempt 1/10 2016-08-07 16:57:16,209 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/763fe887c37c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-07 16:57:16,634 unpacking tar archive at: fx-team-763fe887c37c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.760107 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 16:57:16.365717) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-07 16:57:16.366024) ========= script_repo_revision: 763fe887c37cee5fcfe0f00e94fdffc84a41ea1c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-07 16:57:16.366485) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-07 16:57:16.366813) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-07 16:57:16.377037) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-08-07 16:57:16.377351) ========= /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=20e666a3d4cfbb71505a330e000001b4-1470614235.321695-453361860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:57:17 INFO - MultiFileLogger online at 20160807 16:57:17 in /builds/slave/test 16:57:17 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 16:57:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:57:17 INFO - {'append_to_log': False, 16:57:17 INFO - 'base_work_dir': '/builds/slave/test', 16:57:17 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 16:57:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:57:17 INFO - 'branch': 'Fx-Team-Non-PGO', 16:57:17 INFO - 'buildbot_json_path': 'buildprops.json', 16:57:17 INFO - 'config_files': ('talos/linux_config.py',), 16:57:17 INFO - 'default_actions': ('clobber', 16:57:17 INFO - 'read-buildbot-config', 16:57:17 INFO - 'download-and-extract', 16:57:17 INFO - 'populate-webroot', 16:57:17 INFO - 'create-virtualenv', 16:57:17 INFO - 'install', 16:57:17 INFO - 'run-tests'), 16:57:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:57:17 INFO - 'download_minidump_stackwalk': True, 16:57:17 INFO - 'download_symbols': 'ondemand', 16:57:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:57:17 INFO - 'tooltool.py': '/tools/tooltool.py', 16:57:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:57:17 INFO - '/tools/misc-python/virtualenv.py')}, 16:57:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:57:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:57:17 INFO - 'installer_path': 'installer.exe', 16:57:17 INFO - 'log_level': 'info', 16:57:17 INFO - 'log_name': 'talos', 16:57:17 INFO - 'log_to_console': True, 16:57:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:57:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:57:17 INFO - 'opt_config_files': (), 16:57:17 INFO - 'pip_index': False, 16:57:17 INFO - 'sps_profile': False, 16:57:17 INFO - 'sps_profile_interval': 0, 16:57:17 INFO - 'suite': 'dromaeojs', 16:57:17 INFO - 'system_bits': '32', 16:57:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:57:17 INFO - 'title': 'talos-linux64-ix-015', 16:57:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:57:17 INFO - 'use_talos_json': True, 16:57:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:57:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:57:17 INFO - 'work_dir': 'build'} 16:57:17 INFO - [mozharness: 2016-08-07 23:57:17.098048Z] Running clobber step. 16:57:17 INFO - Running pre-action listener: _resource_record_pre_action 16:57:17 INFO - Running main action method: clobber 16:57:17 INFO - rmtree: /builds/slave/test/build 16:57:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:57:18 INFO - Running post-action listener: _resource_record_post_action 16:57:18 INFO - [mozharness: 2016-08-07 23:57:18.109162Z] Finished clobber step (success) 16:57:18 INFO - [mozharness: 2016-08-07 23:57:18.109263Z] Running read-buildbot-config step. 16:57:18 INFO - Running pre-action listener: _resource_record_pre_action 16:57:18 INFO - Running main action method: read_buildbot_config 16:57:18 INFO - Using buildbot properties: 16:57:18 INFO - { 16:57:18 INFO - "project": "", 16:57:18 INFO - "product": "firefox", 16:57:18 INFO - "script_repo_revision": "production", 16:57:18 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:57:18 INFO - "repository": "", 16:57:18 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 16:57:18 INFO - "buildid": "20160807150652", 16:57:18 INFO - "pgo_build": "False", 16:57:18 INFO - "basedir": "/builds/slave/test", 16:57:18 INFO - "buildnumber": 2075, 16:57:18 INFO - "slavename": "talos-linux64-ix-015", 16:57:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:57:18 INFO - "platform": "ubuntu64_hw", 16:57:18 INFO - "scheduler": "tests-fx-team-linux64-talos-7-3600", 16:57:18 INFO - "branch": "fx-team", 16:57:18 INFO - "repo_path": "integration/fx-team", 16:57:18 INFO - "revision": "763fe887c37cee5fcfe0f00e94fdffc84a41ea1c", 16:57:18 INFO - "stage_platform": "linux64", 16:57:18 INFO - "builduid": "5d0255e5fbda4650869c42fbb26aebb6", 16:57:18 INFO - "slavebuilddir": "test" 16:57:18 INFO - } 16:57:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/K0pQ_17-StKRnMs7IK1ykg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 16:57:18 INFO - Running post-action listener: _resource_record_post_action 16:57:18 INFO - [mozharness: 2016-08-07 23:57:18.111737Z] Finished read-buildbot-config step (success) 16:57:18 INFO - [mozharness: 2016-08-07 23:57:18.111827Z] Running download-and-extract step. 16:57:18 INFO - Running pre-action listener: _resource_record_pre_action 16:57:18 INFO - Running main action method: download_and_extract 16:57:18 INFO - mkdir: /builds/slave/test/build/tests 16:57:18 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')]} 16:57:18 INFO - trying https://queue.taskcluster.net/v1/task/K0pQ_17-StKRnMs7IK1ykg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:57:18 INFO - Downloading https://queue.taskcluster.net/v1/task/K0pQ_17-StKRnMs7IK1ykg/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 16:57:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K0pQ_17-StKRnMs7IK1ykg/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 16:57:18 INFO - Downloaded 1361 bytes. 16:57:18 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:57:18 INFO - Using the following test package requirements: 16:57:18 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:57:18 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:57:18 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:57:18 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:57:18 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:57:18 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:57:18 INFO - u'jsshell-linux-x86_64.zip'], 16:57:18 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:57:18 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:57:18 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:57:18 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:57:18 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:57:18 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:57:18 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:57:18 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:57:18 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:57:18 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:57:18 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:57:18 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:57:18 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')]} 16:57:18 INFO - trying https://queue.taskcluster.net/v1/task/K0pQ_17-StKRnMs7IK1ykg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:57:18 INFO - Downloading https://queue.taskcluster.net/v1/task/K0pQ_17-StKRnMs7IK1ykg/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 16:57:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K0pQ_17-StKRnMs7IK1ykg/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 16:57:21 INFO - Downloaded 20257784 bytes. 16:57:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:57:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:57:22 INFO - Return code: 0 16:57:22 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 16:57:22 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')]} 16:57:22 INFO - trying https://queue.taskcluster.net/v1/task/K0pQ_17-StKRnMs7IK1ykg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:57:22 INFO - Downloading https://queue.taskcluster.net/v1/task/K0pQ_17-StKRnMs7IK1ykg/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 16:57:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K0pQ_17-StKRnMs7IK1ykg/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 16:57:23 INFO - Downloaded 20257784 bytes. 16:57:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:57:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:57:24 INFO - Return code: 0 16:57:24 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')]} 16:57:24 INFO - trying https://queue.taskcluster.net/v1/task/K0pQ_17-StKRnMs7IK1ykg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 16:57:24 INFO - Downloading https://queue.taskcluster.net/v1/task/K0pQ_17-StKRnMs7IK1ykg/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 16:57:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K0pQ_17-StKRnMs7IK1ykg/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 16:57:26 INFO - Downloaded 14413723 bytes. 16:57:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:57:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:57:26 INFO - Return code: 0 16:57:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:26 INFO - trying https://queue.taskcluster.net/v1/task/K0pQ_17-StKRnMs7IK1ykg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:57:26 INFO - Downloading https://queue.taskcluster.net/v1/task/K0pQ_17-StKRnMs7IK1ykg/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 16:57:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K0pQ_17-StKRnMs7IK1ykg/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 16:57:28 INFO - Downloaded 56131100 bytes. 16:57:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K0pQ_17-StKRnMs7IK1ykg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:57:28 INFO - mkdir: /builds/slave/test/properties 16:57:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:57:28 INFO - Writing to file /builds/slave/test/properties/build_url 16:57:28 INFO - Contents: 16:57:28 INFO - build_url:https://queue.taskcluster.net/v1/task/K0pQ_17-StKRnMs7IK1ykg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:57:29 INFO - Running post-action listener: _resource_record_post_action 16:57:29 INFO - Running post-action listener: set_extra_try_arguments 16:57:29 INFO - [mozharness: 2016-08-07 23:57:29.427748Z] Finished download-and-extract step (success) 16:57:29 INFO - [mozharness: 2016-08-07 23:57:29.427982Z] Running populate-webroot step. 16:57:29 INFO - Running pre-action listener: _resource_record_pre_action 16:57:29 INFO - Running main action method: populate_webroot 16:57:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:57:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:57:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:57:29 INFO - '--tppagecycles', 16:57:29 INFO - '7'], 16:57:29 INFO - 'tests': ['tsvgm']}}, 16:57:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:57:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:57:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:57:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:57:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:57:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:57:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:29 INFO - 'talos_options': ['--disable-e10s'], 16:57:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:57:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:57:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:29 INFO - 'talos_options': ['--disable-e10s'], 16:57:29 INFO - 'tests': ['damp', 'tps']}, 16:57:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:29 INFO - 'tests': ['damp', 'tps']}, 16:57:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:57:29 INFO - 'tests': ['dromaeo_dom']}, 16:57:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:57:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:57:29 INFO - 'tests': ['basic_compositor_video']}, 16:57:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:57:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:57:29 INFO - 'tests': ['a11yr', 16:57:29 INFO - 'ts_paint', 16:57:29 INFO - 'tpaint', 16:57:29 INFO - 'sessionrestore', 16:57:29 INFO - 'sessionrestore_no_auto_restore', 16:57:29 INFO - 'tabpaint']}, 16:57:29 INFO - 'other-e10s': {'tests': ['a11yr', 16:57:29 INFO - 'ts_paint', 16:57:29 INFO - 'tpaint', 16:57:29 INFO - 'sessionrestore', 16:57:29 INFO - 'sessionrestore_no_auto_restore', 16:57:29 INFO - 'tabpaint']}, 16:57:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:57:29 INFO - 'ts_paint', 16:57:29 INFO - 'tpaint', 16:57:29 INFO - 'sessionrestore', 16:57:29 INFO - 'sessionrestore_no_auto_restore', 16:57:29 INFO - 'tabpaint']}, 16:57:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:57:29 INFO - 'ts_paint', 16:57:29 INFO - 'tpaint', 16:57:29 INFO - 'sessionrestore', 16:57:29 INFO - 'sessionrestore_no_auto_restore', 16:57:29 INFO - 'tabpaint']}, 16:57:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:57:29 INFO - 'tests': ['a11yr', 16:57:29 INFO - 'ts_paint', 16:57:29 INFO - 'tpaint', 16:57:29 INFO - 'sessionrestore', 16:57:29 INFO - 'sessionrestore_no_auto_restore', 16:57:29 INFO - 'tabpaint']}, 16:57:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:57:29 INFO - 'tests': ['a11yr', 16:57:29 INFO - 'ts_paint', 16:57:29 INFO - 'tpaint', 16:57:29 INFO - 'sessionrestore', 16:57:29 INFO - 'sessionrestore_no_auto_restore', 16:57:29 INFO - 'tabpaint']}, 16:57:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:57:29 INFO - 'tests': ['tsvgx', 16:57:29 INFO - 'tsvgr_opacity', 16:57:29 INFO - 'tart', 16:57:29 INFO - 'tscrollx', 16:57:29 INFO - 'cart']}, 16:57:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:57:29 INFO - 'tsvgr_opacity', 16:57:29 INFO - 'tart', 16:57:29 INFO - 'tscrollx', 16:57:29 INFO - 'cart']}, 16:57:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:29 INFO - 'talos_options': ['--disable-e10s'], 16:57:29 INFO - 'tests': ['tp5o']}, 16:57:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:29 INFO - 'tests': ['tp5o']}, 16:57:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:29 INFO - 'talos_options': ['--disable-e10s', 16:57:29 INFO - '--xperf_path', 16:57:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:57:29 INFO - 'tests': ['tp5n']}, 16:57:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:29 INFO - 'talos_options': ['--xperf_path', 16:57:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:57:29 INFO - 'tests': ['tp5n']}}, 16:57:29 INFO - 'talos.zip': {'path': '', 16:57:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:57:29 INFO - Running post-action listener: _resource_record_post_action 16:57:29 INFO - [mozharness: 2016-08-07 23:57:29.444905Z] Finished populate-webroot step (success) 16:57:29 INFO - [mozharness: 2016-08-07 23:57:29.444994Z] Running create-virtualenv step. 16:57:29 INFO - Running pre-action listener: _resource_record_pre_action 16:57:29 INFO - Running main action method: create_virtualenv 16:57:29 INFO - Creating virtualenv /builds/slave/test/build/venv 16:57:29 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 16:57:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:57:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:57:29 INFO - Using real prefix '/usr' 16:57:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:57:30 INFO - Installing distribute.............................................................................................................................................................................................done. 16:57:32 INFO - Installing pip.................done. 16:57:32 INFO - Return code: 0 16:57:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:57:32 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')]} 16:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:32 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')]} 16:57:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:32 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 0x22af030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2570180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256e3b0>, '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 0x256f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x256f740>, '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': '20e666a3d4cfbb71505a330e000001b4-1470614235.321695-453361860', '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 16:57:32 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 16:57:32 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 16:57:32 INFO - Using env: {'DISPLAY': ':0', 16:57:32 INFO - 'HOME': '/home/cltbld', 16:57:32 INFO - 'LANG': 'en_US.UTF-8', 16:57:32 INFO - 'LANGUAGE': 'en_US:en', 16:57:32 INFO - 'LOGNAME': 'cltbld', 16:57:32 INFO - 'MAIL': '/var/mail/cltbld', 16:57:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:32 INFO - 'MOZ_NO_REMOTE': '1', 16:57:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:32 INFO - 'NO_EM_RESTART': '1', 16:57:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:32 INFO - 'PWD': '/builds/slave/test', 16:57:32 INFO - 'SHELL': '/bin/bash', 16:57:32 INFO - 'SHLVL': '1', 16:57:32 INFO - 'TERM': 'linux', 16:57:32 INFO - 'TMOUT': '86400', 16:57:32 INFO - 'USER': 'cltbld', 16:57:32 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1470614235.321695-453361860', 16:57:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:32 INFO - '_': '/tools/buildbot/bin/python'} 16:57:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:32 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 16:57:32 INFO - Cleaning up... 16:57:32 INFO - Return code: 0 16:57:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:57:32 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')]} 16:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:32 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')]} 16:57:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:32 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 0x22af030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2570180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256e3b0>, '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 0x256f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x256f740>, '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': '20e666a3d4cfbb71505a330e000001b4-1470614235.321695-453361860', '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 16:57:32 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 16:57:32 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 16:57:32 INFO - Using env: {'DISPLAY': ':0', 16:57:32 INFO - 'HOME': '/home/cltbld', 16:57:32 INFO - 'LANG': 'en_US.UTF-8', 16:57:32 INFO - 'LANGUAGE': 'en_US:en', 16:57:32 INFO - 'LOGNAME': 'cltbld', 16:57:32 INFO - 'MAIL': '/var/mail/cltbld', 16:57:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:32 INFO - 'MOZ_NO_REMOTE': '1', 16:57:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:32 INFO - 'NO_EM_RESTART': '1', 16:57:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:32 INFO - 'PWD': '/builds/slave/test', 16:57:32 INFO - 'SHELL': '/bin/bash', 16:57:32 INFO - 'SHLVL': '1', 16:57:32 INFO - 'TERM': 'linux', 16:57:32 INFO - 'TMOUT': '86400', 16:57:32 INFO - 'USER': 'cltbld', 16:57:32 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1470614235.321695-453361860', 16:57:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:32 INFO - '_': '/tools/buildbot/bin/python'} 16:57:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:32 INFO - Downloading/unpacking psutil>=3.1.1 16:57:32 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 16:57:32 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 16:57:32 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 16:57:32 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 16:57:32 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 16:57:32 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 16:57:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:57:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:57:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:57:34 INFO - Installing collected packages: psutil 16:57:34 INFO - Running setup.py install for psutil 16:57:34 INFO - building 'psutil._psutil_linux' extension 16:57:34 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 16:57:34 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 16:57:34 INFO - building 'psutil._psutil_posix' extension 16:57:34 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 16:57:34 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 16:57:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:57:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:57:34 INFO - Successfully installed psutil 16:57:34 INFO - Cleaning up... 16:57:35 INFO - Return code: 0 16:57:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:57:35 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')]} 16:57:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:35 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')]} 16:57:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:35 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 0x22af030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2570180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256e3b0>, '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 0x256f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x256f740>, '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': '20e666a3d4cfbb71505a330e000001b4-1470614235.321695-453361860', '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 16:57:35 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 16:57:35 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 16:57:35 INFO - Using env: {'DISPLAY': ':0', 16:57:35 INFO - 'HOME': '/home/cltbld', 16:57:35 INFO - 'LANG': 'en_US.UTF-8', 16:57:35 INFO - 'LANGUAGE': 'en_US:en', 16:57:35 INFO - 'LOGNAME': 'cltbld', 16:57:35 INFO - 'MAIL': '/var/mail/cltbld', 16:57:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:35 INFO - 'MOZ_NO_REMOTE': '1', 16:57:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:35 INFO - 'NO_EM_RESTART': '1', 16:57:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:35 INFO - 'PWD': '/builds/slave/test', 16:57:35 INFO - 'SHELL': '/bin/bash', 16:57:35 INFO - 'SHLVL': '1', 16:57:35 INFO - 'TERM': 'linux', 16:57:35 INFO - 'TMOUT': '86400', 16:57:35 INFO - 'USER': 'cltbld', 16:57:35 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1470614235.321695-453361860', 16:57:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:35 INFO - '_': '/tools/buildbot/bin/python'} 16:57:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:57:35 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 16:57:35 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 16:57:35 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 16:57:35 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 16:57:35 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 16:57:35 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 16:57:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:57:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:57:37 INFO - Installing collected packages: mozsystemmonitor 16:57:37 INFO - Running setup.py install for mozsystemmonitor 16:57:37 INFO - Successfully installed mozsystemmonitor 16:57:37 INFO - Cleaning up... 16:57:37 INFO - Return code: 0 16:57:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:57: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')]} 16:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57: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')]} 16:57:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:37 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 0x22af030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2570180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256e3b0>, '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 0x256f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x256f740>, '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': '20e666a3d4cfbb71505a330e000001b4-1470614235.321695-453361860', '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 16:57:37 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 16:57:37 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 16:57:37 INFO - Using env: {'DISPLAY': ':0', 16:57:37 INFO - 'HOME': '/home/cltbld', 16:57:37 INFO - 'LANG': 'en_US.UTF-8', 16:57:37 INFO - 'LANGUAGE': 'en_US:en', 16:57:37 INFO - 'LOGNAME': 'cltbld', 16:57:37 INFO - 'MAIL': '/var/mail/cltbld', 16:57:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:37 INFO - 'MOZ_NO_REMOTE': '1', 16:57:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:37 INFO - 'NO_EM_RESTART': '1', 16:57:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:37 INFO - 'PWD': '/builds/slave/test', 16:57:37 INFO - 'SHELL': '/bin/bash', 16:57:37 INFO - 'SHLVL': '1', 16:57:37 INFO - 'TERM': 'linux', 16:57:37 INFO - 'TMOUT': '86400', 16:57:37 INFO - 'USER': 'cltbld', 16:57:37 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1470614235.321695-453361860', 16:57:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:37 INFO - '_': '/tools/buildbot/bin/python'} 16:57:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:37 INFO - Downloading/unpacking jsonschema==2.5.1 16:57:37 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 16:57:37 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 16:57:37 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 16:57:37 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 16:57:37 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 16:57:37 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 16:57:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:57:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:57:39 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 16:57:39 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 16:57:39 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 16:57:39 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 16:57:39 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 16:57:39 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 16:57:39 INFO - Downloading functools32-3.2.3-2.tar.gz 16:57:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:57:39 INFO - warning: no files found matching '*.txt' 16:57:39 INFO - no previously-included directories found matching 'build' 16:57:39 INFO - no previously-included directories found matching 'dist' 16:57:39 INFO - no previously-included directories found matching '.git*' 16:57:39 INFO - Installing collected packages: jsonschema, functools32 16:57:39 INFO - Running setup.py install for functools32 16:57:39 INFO - warning: no files found matching '*.txt' 16:57:39 INFO - no previously-included directories found matching 'build' 16:57:39 INFO - no previously-included directories found matching 'dist' 16:57:39 INFO - no previously-included directories found matching '.git*' 16:57:39 INFO - Successfully installed jsonschema functools32 16:57:39 INFO - Cleaning up... 16:57:39 INFO - Return code: 0 16:57:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:57:39 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')]} 16:57:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:39 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')]} 16:57:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:39 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 0x22af030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2570180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256e3b0>, '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 0x256f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x256f740>, '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': '20e666a3d4cfbb71505a330e000001b4-1470614235.321695-453361860', '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 16:57:39 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 16:57:39 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 16:57:39 INFO - Using env: {'DISPLAY': ':0', 16:57:39 INFO - 'HOME': '/home/cltbld', 16:57:39 INFO - 'LANG': 'en_US.UTF-8', 16:57:39 INFO - 'LANGUAGE': 'en_US:en', 16:57:39 INFO - 'LOGNAME': 'cltbld', 16:57:39 INFO - 'MAIL': '/var/mail/cltbld', 16:57:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:39 INFO - 'MOZ_NO_REMOTE': '1', 16:57:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:39 INFO - 'NO_EM_RESTART': '1', 16:57:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:39 INFO - 'PWD': '/builds/slave/test', 16:57:39 INFO - 'SHELL': '/bin/bash', 16:57:39 INFO - 'SHLVL': '1', 16:57:39 INFO - 'TERM': 'linux', 16:57:39 INFO - 'TMOUT': '86400', 16:57:39 INFO - 'USER': 'cltbld', 16:57:39 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1470614235.321695-453361860', 16:57:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:39 INFO - '_': '/tools/buildbot/bin/python'} 16:57:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:57:40 INFO - Cleaning up... 16:57:40 INFO - Return code: 0 16:57:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:57:40 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')]} 16:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:40 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')]} 16:57:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:40 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 0x22af030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2570180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256e3b0>, '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 0x256f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x256f740>, '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': '20e666a3d4cfbb71505a330e000001b4-1470614235.321695-453361860', '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 16:57:40 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 16:57:40 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 16:57:40 INFO - Using env: {'DISPLAY': ':0', 16:57:40 INFO - 'HOME': '/home/cltbld', 16:57:40 INFO - 'LANG': 'en_US.UTF-8', 16:57:40 INFO - 'LANGUAGE': 'en_US:en', 16:57:40 INFO - 'LOGNAME': 'cltbld', 16:57:40 INFO - 'MAIL': '/var/mail/cltbld', 16:57:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:40 INFO - 'MOZ_NO_REMOTE': '1', 16:57:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:40 INFO - 'NO_EM_RESTART': '1', 16:57:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:40 INFO - 'PWD': '/builds/slave/test', 16:57:40 INFO - 'SHELL': '/bin/bash', 16:57:40 INFO - 'SHLVL': '1', 16:57:40 INFO - 'TERM': 'linux', 16:57:40 INFO - 'TMOUT': '86400', 16:57:40 INFO - 'USER': 'cltbld', 16:57:40 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1470614235.321695-453361860', 16:57:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:40 INFO - '_': '/tools/buildbot/bin/python'} 16:57:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:40 INFO - Downloading/unpacking blobuploader==1.2.4 16:57:40 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 16:57:40 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 16:57:40 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 16:57:40 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 16:57:40 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 16:57:40 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 16:57:42 INFO - Downloading blobuploader-1.2.4.tar.gz 16:57:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:57:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:57:42 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 16:57:42 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 16:57:42 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 16:57:42 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 16:57:42 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 16:57:42 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 16:57:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:57:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:57:42 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 16:57:42 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 16:57:42 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 16:57:42 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 16:57:42 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 16:57:42 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 16:57:42 INFO - Downloading docopt-0.6.1.tar.gz 16:57:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:57:42 INFO - Installing collected packages: blobuploader, requests, docopt 16:57:42 INFO - Running setup.py install for blobuploader 16:57:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:57:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:57:43 INFO - Running setup.py install for requests 16:57:43 INFO - Running setup.py install for docopt 16:57:43 INFO - Successfully installed blobuploader requests docopt 16:57:43 INFO - Cleaning up... 16:57:43 INFO - Return code: 0 16:57:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:57: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')]} 16:57:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57: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')]} 16:57:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:43 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 0x22af030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2570180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256e3b0>, '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 0x256f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x256f740>, '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': '20e666a3d4cfbb71505a330e000001b4-1470614235.321695-453361860', '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 16:57:43 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 16:57:43 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 16:57:43 INFO - Using env: {'DISPLAY': ':0', 16:57:43 INFO - 'HOME': '/home/cltbld', 16:57:43 INFO - 'LANG': 'en_US.UTF-8', 16:57:43 INFO - 'LANGUAGE': 'en_US:en', 16:57:43 INFO - 'LOGNAME': 'cltbld', 16:57:43 INFO - 'MAIL': '/var/mail/cltbld', 16:57:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:43 INFO - 'MOZ_NO_REMOTE': '1', 16:57:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:43 INFO - 'NO_EM_RESTART': '1', 16:57:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:43 INFO - 'PWD': '/builds/slave/test', 16:57:43 INFO - 'SHELL': '/bin/bash', 16:57:43 INFO - 'SHLVL': '1', 16:57:43 INFO - 'TERM': 'linux', 16:57:43 INFO - 'TMOUT': '86400', 16:57:43 INFO - 'USER': 'cltbld', 16:57:43 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1470614235.321695-453361860', 16:57:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:43 INFO - '_': '/tools/buildbot/bin/python'} 16:57:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:57:43 INFO - Running setup.py (path:/tmp/pip-SRRb_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:57:43 INFO - Running setup.py (path:/tmp/pip-LwgERe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:57:43 INFO - Running setup.py (path:/tmp/pip-nhRAxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:57:43 INFO - Running setup.py (path:/tmp/pip-upLHjW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:57:44 INFO - Running setup.py (path:/tmp/pip-XOIcxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:57:44 INFO - Running setup.py (path:/tmp/pip-JOtIzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:57:44 INFO - Running setup.py (path:/tmp/pip-kAGwkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:57:44 INFO - Running setup.py (path:/tmp/pip-cTFL_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:57:44 INFO - Running setup.py (path:/tmp/pip-ydSxLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:57:44 INFO - Running setup.py (path:/tmp/pip-bbUaUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:57:44 INFO - Running setup.py (path:/tmp/pip-BfJN_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:57:44 INFO - Running setup.py (path:/tmp/pip-f5u0sK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:57:44 INFO - Running setup.py (path:/tmp/pip-2aFV8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:57:44 INFO - Running setup.py (path:/tmp/pip-qnEYYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:57:44 INFO - Running setup.py (path:/tmp/pip-6LmHX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:57:44 INFO - Running setup.py (path:/tmp/pip-nyMFYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:57:44 INFO - Running setup.py (path:/tmp/pip-8DyF5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:57:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:57:44 INFO - Running setup.py install for manifestparser 16:57:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:57:45 INFO - Running setup.py install for mozcrash 16:57:45 INFO - Running setup.py install for mozdebug 16:57:45 INFO - Running setup.py install for mozdevice 16:57:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:57:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:57:45 INFO - Running setup.py install for mozfile 16:57:45 INFO - Running setup.py install for mozhttpd 16:57:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:57:45 INFO - Running setup.py install for mozinfo 16:57:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:57:45 INFO - Running setup.py install for mozInstall 16:57:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:57:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:57:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:57:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:57:45 INFO - Running setup.py install for mozleak 16:57:45 INFO - Running setup.py install for mozlog 16:57:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:57:46 INFO - Running setup.py install for moznetwork 16:57:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:57:46 INFO - Running setup.py install for mozprocess 16:57:46 INFO - Running setup.py install for mozprofile 16:57:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:57:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:57:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:57:46 INFO - Running setup.py install for mozrunner 16:57:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:57:46 INFO - Running setup.py install for mozscreenshot 16:57:46 INFO - Running setup.py install for moztest 16:57:46 INFO - Running setup.py install for mozversion 16:57:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:57:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:57:46 INFO - Cleaning up... 16:57:46 INFO - Return code: 0 16:57:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:57:46 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')]} 16:57:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:46 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')]} 16:57:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:46 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 0x22af030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2570180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256e3b0>, '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 0x256f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x256f740>, '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': '20e666a3d4cfbb71505a330e000001b4-1470614235.321695-453361860', '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 16:57:46 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 16:57:46 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 16:57:46 INFO - Using env: {'DISPLAY': ':0', 16:57:46 INFO - 'HOME': '/home/cltbld', 16:57:46 INFO - 'LANG': 'en_US.UTF-8', 16:57:46 INFO - 'LANGUAGE': 'en_US:en', 16:57:46 INFO - 'LOGNAME': 'cltbld', 16:57:46 INFO - 'MAIL': '/var/mail/cltbld', 16:57:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:46 INFO - 'MOZ_NO_REMOTE': '1', 16:57:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:46 INFO - 'NO_EM_RESTART': '1', 16:57:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:46 INFO - 'PWD': '/builds/slave/test', 16:57:46 INFO - 'SHELL': '/bin/bash', 16:57:46 INFO - 'SHLVL': '1', 16:57:46 INFO - 'TERM': 'linux', 16:57:46 INFO - 'TMOUT': '86400', 16:57:46 INFO - 'USER': 'cltbld', 16:57:46 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1470614235.321695-453361860', 16:57:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:46 INFO - '_': '/tools/buildbot/bin/python'} 16:57:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:57:46 INFO - Running setup.py (path:/tmp/pip-kMVDXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:57:47 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)) 16:57:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:57:47 INFO - Running setup.py (path:/tmp/pip-pgsogZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:57:47 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)) 16:57:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:57:47 INFO - Running setup.py (path:/tmp/pip-ZzTnLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:57:47 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)) 16:57:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:57:47 INFO - Running setup.py (path:/tmp/pip-HTNgYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:57:47 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)) 16:57:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:57:47 INFO - Running setup.py (path:/tmp/pip-KGEfTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:57:47 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)) 16:57:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:57:47 INFO - Running setup.py (path:/tmp/pip-U8n7fu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:57:47 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)) 16:57:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:57:47 INFO - Running setup.py (path:/tmp/pip-HuUWPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:57:47 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)) 16:57:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:57:47 INFO - Running setup.py (path:/tmp/pip-0rZSJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:57:47 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)) 16:57:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:57:47 INFO - Running setup.py (path:/tmp/pip-XklWTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:57:47 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)) 16:57:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:57:47 INFO - Running setup.py (path:/tmp/pip-z1WMi3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:57:47 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)) 16:57:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:57:47 INFO - Running setup.py (path:/tmp/pip-Vj2hq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:57:47 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)) 16:57:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:57:47 INFO - Running setup.py (path:/tmp/pip-sShQxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:57:47 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)) 16:57:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:57:47 INFO - Running setup.py (path:/tmp/pip-2gAInQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:57:47 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)) 16:57:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:57:47 INFO - Running setup.py (path:/tmp/pip-5vU3Bn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:57:48 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)) 16:57:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:57:48 INFO - Running setup.py (path:/tmp/pip-rezLc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:57:48 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)) 16:57:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:57:48 INFO - Running setup.py (path:/tmp/pip-Z58VPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:57:48 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)) 16:57:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:57:48 INFO - Running setup.py (path:/tmp/pip-kiq9VN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:57:48 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)) 16:57:48 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)) 16:57:48 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)) 16:57:48 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)) 16:57:48 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)) 16:57:48 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)) 16:57:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:57:48 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 16:57:48 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 16:57:48 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 16:57:48 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 16:57:48 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 16:57:48 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 16:57:50 INFO - Downloading blessings-1.6.tar.gz 16:57:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:57:50 INFO - Installing collected packages: blessings 16:57:50 INFO - Running setup.py install for blessings 16:57:50 INFO - Successfully installed blessings 16:57:50 INFO - Cleaning up... 16:57:50 INFO - Return code: 0 16:57:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:57:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:57:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:57:50 INFO - Reading from file tmpfile_stdout 16:57:50 INFO - Current package versions: 16:57:50 INFO - argparse == 1.2.1 16:57:50 INFO - blessings == 1.6 16:57:50 INFO - blobuploader == 1.2.4 16:57:50 INFO - docopt == 0.6.1 16:57:50 INFO - functools32 == 3.2.3-2 16:57:50 INFO - jsonschema == 2.5.1 16:57:50 INFO - manifestparser == 1.1 16:57:50 INFO - mozInstall == 1.12 16:57:50 INFO - mozcrash == 0.17 16:57:50 INFO - mozdebug == 0.1 16:57:50 INFO - mozdevice == 0.48 16:57:50 INFO - mozfile == 1.2 16:57:50 INFO - mozhttpd == 0.7 16:57:50 INFO - mozinfo == 0.9 16:57:50 INFO - mozleak == 0.1 16:57:50 INFO - mozlog == 3.3 16:57:50 INFO - moznetwork == 0.27 16:57:50 INFO - mozprocess == 0.23 16:57:50 INFO - mozprofile == 0.28 16:57:50 INFO - mozrunner == 6.12 16:57:50 INFO - mozscreenshot == 0.1 16:57:50 INFO - mozsystemmonitor == 0.3 16:57:50 INFO - moztest == 0.7 16:57:50 INFO - mozversion == 1.4 16:57:50 INFO - psutil == 3.1.1 16:57:50 INFO - requests == 1.2.3 16:57:50 INFO - wsgiref == 0.1.2 16:57:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:57: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')]} 16:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57: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')]} 16:57:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:50 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 0x22af030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2570180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256e3b0>, '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 0x256f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x256f740>, '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': '20e666a3d4cfbb71505a330e000001b4-1470614235.321695-453361860', '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 16:57:50 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 16:57:50 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 16:57:50 INFO - Using env: {'DISPLAY': ':0', 16:57:50 INFO - 'HOME': '/home/cltbld', 16:57:50 INFO - 'LANG': 'en_US.UTF-8', 16:57:50 INFO - 'LANGUAGE': 'en_US:en', 16:57:50 INFO - 'LOGNAME': 'cltbld', 16:57:50 INFO - 'MAIL': '/var/mail/cltbld', 16:57:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:50 INFO - 'MOZ_NO_REMOTE': '1', 16:57:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:50 INFO - 'NO_EM_RESTART': '1', 16:57:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:50 INFO - 'PWD': '/builds/slave/test', 16:57:50 INFO - 'SHELL': '/bin/bash', 16:57:50 INFO - 'SHLVL': '1', 16:57:50 INFO - 'TERM': 'linux', 16:57:50 INFO - 'TMOUT': '86400', 16:57:50 INFO - 'USER': 'cltbld', 16:57:50 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1470614235.321695-453361860', 16:57:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:50 INFO - '_': '/tools/buildbot/bin/python'} 16:57:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:50 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)) 16:57:50 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)) 16:57:50 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)) 16:57:50 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)) 16:57:50 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)) 16:57:50 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)) 16:57:50 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)) 16:57:50 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)) 16:57:50 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)) 16:57:50 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)) 16:57:50 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)) 16:57:50 INFO - Cleaning up... 16:57:50 INFO - Return code: 0 16:57:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:57: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')]} 16:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57: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')]} 16:57:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:50 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 0x22af030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2570180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x256e3b0>, '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 0x256f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x256f740>, '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': '20e666a3d4cfbb71505a330e000001b4-1470614235.321695-453361860', '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 16:57:50 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 16:57:50 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 16:57:50 INFO - Using env: {'DISPLAY': ':0', 16:57:50 INFO - 'HOME': '/home/cltbld', 16:57:50 INFO - 'LANG': 'en_US.UTF-8', 16:57:50 INFO - 'LANGUAGE': 'en_US:en', 16:57:50 INFO - 'LOGNAME': 'cltbld', 16:57:50 INFO - 'MAIL': '/var/mail/cltbld', 16:57:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:50 INFO - 'MOZ_NO_REMOTE': '1', 16:57:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:50 INFO - 'NO_EM_RESTART': '1', 16:57:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:50 INFO - 'PWD': '/builds/slave/test', 16:57:50 INFO - 'SHELL': '/bin/bash', 16:57:50 INFO - 'SHLVL': '1', 16:57:50 INFO - 'TERM': 'linux', 16:57:50 INFO - 'TMOUT': '86400', 16:57:50 INFO - 'USER': 'cltbld', 16:57:50 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1470614235.321695-453361860', 16:57:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:50 INFO - '_': '/tools/buildbot/bin/python'} 16:57:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:57:50 INFO - Cleaning up... 16:57:51 INFO - Return code: 0 16:57:51 INFO - Running post-action listener: _resource_record_post_action 16:57:51 INFO - Running post-action listener: _start_resource_monitoring 16:57:51 INFO - Starting resource monitoring. 16:57:51 INFO - [mozharness: 2016-08-07 23:57:51.038146Z] Finished create-virtualenv step (success) 16:57:51 INFO - [mozharness: 2016-08-07 23:57:51.038633Z] Running install step. 16:57:51 INFO - Running pre-action listener: _resource_record_pre_action 16:57:51 INFO - Running main action method: install 16:57:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:57:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:57:51 INFO - Reading from file tmpfile_stdout 16:57:51 INFO - Detecting whether we're running mozinstall >=1.0... 16:57:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:57:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:57:51 INFO - Reading from file tmpfile_stdout 16:57:51 INFO - Output received: 16:57:51 INFO - Usage: mozinstall [options] installer 16:57:51 INFO - Options: 16:57:51 INFO - -h, --help show this help message and exit 16:57:51 INFO - -d DEST, --destination=DEST 16:57:51 INFO - Directory to install application into. [default: 16:57:51 INFO - "/builds/slave/test"] 16:57:51 INFO - --app=APP Application being installed. [default: firefox] 16:57:51 INFO - mkdir: /builds/slave/test/build/application 16:57:51 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'] 16:57:51 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 16:58:07 INFO - Reading from file tmpfile_stdout 16:58:07 INFO - Output received: 16:58:07 INFO - /builds/slave/test/build/application/firefox/firefox 16:58:07 INFO - Running post-action listener: _resource_record_post_action 16:58:07 INFO - [mozharness: 2016-08-07 23:58:07.546330Z] Finished install step (success) 16:58:07 INFO - [mozharness: 2016-08-07 23:58:07.546578Z] Running run-tests step. 16:58:07 INFO - Running pre-action listener: _resource_record_pre_action 16:58:07 INFO - Running main action method: run_tests 16:58:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:58:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:58:07 INFO - Python 2.7.3 16:58:07 INFO - Return code: 0 16:58:07 INFO - grabbing minidump binary from tooltool 16:58: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')]} 16:58:07 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 0x256e3b0>, '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 0x256f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x256f740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:58:07 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 16:58:07 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 16:58:07 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 16:58:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:58:07 INFO - Return code: 0 16:58:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:58:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:58:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:58:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:58:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:58:07 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/K0pQ_17-StKRnMs7IK1ykg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 16:58:07 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/K0pQ_17-StKRnMs7IK1ykg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --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 16:58:07 INFO - Using env: {'DISPLAY': ':0', 16:58:07 INFO - 'HOME': '/home/cltbld', 16:58:07 INFO - 'LANG': 'en_US.UTF-8', 16:58:07 INFO - 'LANGUAGE': 'en_US:en', 16:58:07 INFO - 'LOGNAME': 'cltbld', 16:58:07 INFO - 'MAIL': '/var/mail/cltbld', 16:58:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:58:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:58:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:07 INFO - 'MOZ_NO_REMOTE': '1', 16:58:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:58:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:07 INFO - 'NO_EM_RESTART': '1', 16:58:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:07 INFO - 'PWD': '/builds/slave/test', 16:58:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:58:07 INFO - 'SHELL': '/bin/bash', 16:58:07 INFO - 'SHLVL': '1', 16:58:07 INFO - 'TERM': 'linux', 16:58:07 INFO - 'TMOUT': '86400', 16:58:07 INFO - 'USER': 'cltbld', 16:58:07 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1470614235.321695-453361860', 16:58:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:07 INFO - '_': '/tools/buildbot/bin/python'} 16:58:07 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/K0pQ_17-StKRnMs7IK1ykg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 16:58:07 INFO - mozversion application_buildid: 20160807150652 16:58:07 INFO - mozversion application_changeset: 763fe887c37cee5fcfe0f00e94fdffc84a41ea1c 16:58:07 INFO - mozversion application_display_name: Nightly 16:58:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:58:07 INFO - mozversion application_name: Firefox 16:58:07 INFO - mozversion application_remotingname: firefox 16:58:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:58:07 INFO - mozversion application_vendor: Mozilla 16:58:07 INFO - mozversion application_version: 51.0a1 16:58:07 INFO - mozversion platform_buildid: 20160807150652 16:58:07 INFO - mozversion platform_changeset: 763fe887c37cee5fcfe0f00e94fdffc84a41ea1c 16:58:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:58:07 INFO - mozversion platform_version: 51.0a1 16:58:07 INFO - using testdate: 1470614287 16:58:07 INFO - actual date: 1470614287 16:58:07 INFO - starting webserver on 'localhost:34341' 16:58:07 INFO - SUITE-START | Running 2 tests 16:58:07 INFO - TEST-START | dromaeo_css 16:58:07 INFO - operating with platform_type : linux_ 16:58:07 INFO - Initialising browser for dromaeo_css test... 16:58:07 INFO - TEST-INFO | started process 3738 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfac1qZ/profile http://localhost:34341/getInfo.html) 16:58:12 INFO - PROCESS | 3738 | __metrics Screen width/height:1600/1200 16:58:12 INFO - PROCESS | 3738 | colorDepth:24 16:58:12 INFO - PROCESS | 3738 | Browser inner width/height: 1024/697 16:58:12 INFO - PROCESS | 3738 | __metrics 16:58:12 INFO - PROCESS | 3738 | 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" 16:58:12 INFO - PROCESS | 3738 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:58:13 INFO - TEST-INFO | 3738: exit 0 16:58:13 INFO - Browser initialized. 16:58:13 INFO - Running cycle 1/1 for dromaeo_css test... 16:58:13 INFO - TEST-INFO | started process 3818 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfac1qZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:58:25 INFO - PROCESS | 3818 | RSS: Main: 158076928 16:58:25 INFO - PROCESS | 3818 | 16:59:17 INFO - PROCESS | 3818 | 1470614357178 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:01:29 INFO - PROCESS | 3818 | Cycle 1(1): loaded http://localhost:34341/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34341/tests/dromaeo/cssquery-ext.html) 17:01:31 INFO - PROCESS | 3818 | RSS: Main: 249937920 17:01:31 INFO - PROCESS | 3818 | 17:04:33 INFO - PROCESS | 3818 | Cycle 1(1): loaded http://localhost:34341/tests/dromaeo/cssquery-ext.html (next: http://localhost:34341/tests/dromaeo/cssquery-jquery.html) 17:04:34 INFO - PROCESS | 3818 | RSS: Main: 240164864 17:04:34 INFO - PROCESS | 3818 | 17:07:36 INFO - PROCESS | 3818 | Cycle 1(1): loaded http://localhost:34341/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34341/tests/dromaeo/cssquery-mootools.html) 17:07:37 INFO - PROCESS | 3818 | RSS: Main: 220270592 17:07:37 INFO - PROCESS | 3818 | 17:10:39 INFO - PROCESS | 3818 | Cycle 1(1): loaded http://localhost:34341/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34341/tests/dromaeo/cssquery-prototype.html) 17:10:39 INFO - PROCESS | 3818 | RSS: Main: 184877056 17:10:39 INFO - PROCESS | 3818 | 17:13:43 INFO - PROCESS | 3818 | Cycle 1(1): loaded http://localhost:34341/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34341/tests/dromaeo/cssquery-yui.html) 17:13:43 INFO - PROCESS | 3818 | RSS: Main: 185425920 17:13:43 INFO - PROCESS | 3818 | 17:16:46 INFO - PROCESS | 3818 | Cycle 1(1): loaded http://localhost:34341/tests/dromaeo/cssquery-yui.html (next: http://localhost:34341/tests/dromaeo/cssquery-dojo.html) 17:16:46 INFO - PROCESS | 3818 | RSS: Main: 280666112 17:16:46 INFO - PROCESS | 3818 | 17:16:46 INFO - PROCESS | 3818 | __start_tp_report 17:16:46 INFO - PROCESS | 3818 | _x_x_mozilla_page_load 17:16:46 INFO - PROCESS | 3818 | _x_x_mozilla_page_load_details 17:16:46 INFO - PROCESS | 3818 | |i|pagename|runs| 17:16:46 INFO - PROCESS | 3818 | |0;dojo.html;2630.723774003729;2638.076673164392;2640.221134765244;2673.238127133766;2682.745139211774;4506.977465112678;4603.677742558022;4722.437064943491;4838.733869637169;4844.321794948705;4806.255030470274;4828.51714828517;4840.491748366424;4875.951240487594;4885;4286.1213451242575;4414.940414300577;4493.707908985922;4550.635949124062;4592.494825569202;4507.143642707892;4535.387722657449;4553.704009239405;4564.771761411933;4567.977160114195;4258.701890867641;4289.313709806447;4310.698251122422;4390.473143222834;4422.380866678667;4399.252127138362;4404.625606823424;4420.646348292161;4439.866803995886;4527.230370836965;4436.112777444524;4437.911241775147;4441.555844415565;4474.440694913136;4475.216837053503;4540.069285796404;4720.551547603007;4838.975805120987;4887.828925987609;4898.338724272213;5104.64267501275;5144.459831717691;5197.402298735656;5205.765740541685;5206.193040078794;5176.818811341585;5189.896202075975;5221.817236396746;5248.7375631218665;5251.396089449724;4591.989762252299;4743.976280118646;4803.18345881201;4868.294097355863;4871.318015477836;5275.920861187085;5278.5249327560705;5307.893842123136;5309.946900531023;5327.627066105335;5055.69665820052;5093.567046800989;5094.414142373675;5106.361704786902;5113.41195762492;4898.314236006961;5063.3417655704525;5108.106081435734;5195.948040519622;5199.610029247821;5104.566111880457;5106.336176297132;5107.387113546398;5147.845564633067;5152.793888244429;5033.697978121324;5042.067217564689;5043.067032598908;5079.2381142828135;5095.210242412432;4147.04617937876;4180.540140584533;4336.6530677545725;4368.825246990148;4411.647068234533;3812.4090765931323;3835.0412396900774;3875.8837234883;3911.9608803911597;3933.6066393360434;4460.7323560586465;4461.776911154429;4465.553444655508;4467;4513.142502924499;4919.4834542373255;4994.275830004629;5238.659487133325;5240.240165176028;5264.789408423697;4350.717203381833;4395.846145384896;4400.713953593006;4411.977940110279;4459.420275364247;4613.630909527297;4641.419822522184;4644.140833945731;4648.349231107648;4702.976485117552;4630.7453090079025;4793;4829.613630909519;4844.079624871263;4892.168331383673;5126.256692779601;5176.844694659167;5189.506996835295;5201.453847345974;5216.791328346975;4846.442659094249;4850.563449289581;4855.441624213261;4858.1012512685265;4894.535019173173;4816.662833601755;5096.566791822588;5102.36220472441;5105.361829771278;5160.922586161136;4917.729524876167;5107.770150343318;5129.384473863161;5141.126008578625;5230.843074707765;5025.170846810235;5040.470750571138;5042.042012017705;5047.470015648304;5101.285819985279;5026.44709082008;5031.698098113979;5033.194688849767;5038.496150384932;5038.823641172688;4725.267583524559;4877.95122048775;4949.703017818798;4955.628327875496;5028.497150284942;5053.494650534917;5061.266116413173;5068.949310506848;5074.873128171826;5115.616328775282;4656.348111264493;4949.406071271471;4951.455339912679;4955.430125535466;4956.008798240438 17:16:46 INFO - PROCESS | 3818 | |1;ext.html;551.3400102553004;572.9886749886449;583.5623282538096;589.831897909096;596.9761858412821;38235.42646860299;39267.21465570694;39300;39425.211495770105;43458.7827060865;41843.95390115248;42279.57720422802;42351.15297694052;42398.78800606;42446.57553424472;7299.124105107395;7697.615119244029;7905.249001344863;7917.366610671133;9827.213822894188;9658.9517052415;10048.799024019516;10052.849207261861;10053.396796192215;10054;10066.647667331645;10146.898531014705;10153.898461015406;10159.898401016006;10174.236932230075;10003.449810260432;10058.446785426799;10089.142422894063;10091.39451632897;10095;9863.260255480796;9935.950320248425;9937.900620993842;9938.10557049869;9942.353747006422;39597.40603890944;39929.80035099835;40015.79992100021;40037.79981100105;40088.79955600233;2752.119321817019;2754.2425832895915;2886.610307608488;2935.4716151092794;3210.046071026992;29258.41483170346;29579;29780.40439191204;30104.247393815112;30484.695153048408;3422.845971931269;3436.914077148066;3454.5943415955526;3486.337595856779;3487.7384196185135;259505;261940;262119;262415;262625;53743;54110;54154;54228.72885635547;54251.72874135604;32940.341193176006;33903.66096339055;34043.65956340405;35447.29105417877;35672.108197295274;13574.864251357558;13727.245001524812;13759.518416855362;13760.692734190236;13760.793588096187;9031.593578288992;9181.0818918109;9203.217726493323;9433.245340372754;10300.072993430627;16315.51053468398;17679.558011049827;17767.378141765235;18154.18306176225;18656.34702785396;6558.245801732766;6665.1335326408225;6690.498212633975;6768.56004359715;6825.590464572141;828.3952714518315;862.7756783236404;934.1685899549407;956.5647630328184;992.98715310383;26726.465470690866;27903.16290511288;28516.572251416244;28644.427111457655;28660.037855141723;797.3899966525613;822.8230930349883;848.7411339541376;898.7708134425679;926.4070994563485;14744.778828317583;15002.324895379734;15277.847221527643;15427.398005888232;15458.922705386402;373051;377901;378547;379305;379658;50398;50921;50983.235251471255;51039.234411483856;51090.489095108576;1076.0745758647556;1085.7014321061456;1089.4443833644739;1165.2775279326872;1171.7890779659572;22167.391219206365;28564.285892852844;29074.7092529072;29626.407471850875;29662.555061673662;46884.29673554967;47448.52551474441;47522.762386187846;47536;47539;268052;269509;269982;270091;270751;22785.974631141307;23557.646635300825;25646.230613081636;25811.741882581686;26192.73807261979;45238;45337.31994020158;46180;46270.76864615655;46719.532804672875;36473.27053458863;36540.817295914414;36789.44815827818;37226;37617.2476550462;36984.815075924445;37103.81448092742;37435.62564374322;37486.812565937;37617.62382376141;35965;36336;36792.44811327886;37150.628493714714;37464;28469.572956405256;30613.54079688851;30673;30746.231344216572;30910;23653.645195322428;23673;23795.524089518458;24038.51922961496;24107.27678169658 17:16:46 INFO - PROCESS | 3818 | |2;jquery.html;360.4917066935623;363.66542780641805;371.3723806766564;372.86390467479345;375.7088256601134;16643.916780416097;17029.403970861007;17170.656586868256;17256.223469943852;17259.74110388345;16651.916740416313;17109.57226069349;17441.21514531846;17567.385141520048;17630.82369176308;4856.198727210015;5097.23541468779;5100.234964755279;5101.821436249732;5101.821436249732;3749.1189570450924;3939.0546268895546;5011.599072074226;5633.549316054706;5888.146218798272;5942;5952.047672372421;5956.136360227764;5957.374475680056;5957.761689532414;5711.571632127586;5861.765529378819;5899.46904778572;5904.9704751475965;5908.49777768888;5049.242613607951;5190.143626301656;5195.038917800219;5199.090159222159;5199.974000129975;20676.793232067637;21112.894435527876;21192.470188245265;21341.33233345832;21388;1788.204249109147;1888.1503323504478;1918.127252100305;1927.787943326233;1970.655135351322;9192.954035229848;9602.807943841153;9719;12628.116031877773;13096.607101786962;1643.2523201943088;1669.240202771478;1727.723564229717;1808.4665023817874;1812.2750899640118;66790;69118.65440672815;69168.81233907427;69604.99542552621;69991.3000869995;10174.728158980128;10198.33710808795;10355.689329320132;10398.532066057045;10404.375737455777;14367.712645747026;14368.13791172533;14374.85625143756;14388.06477578954;14388.352524136439;7168.92831071693;7313.26867313275;7320.926790732131;7361.705531778776;7380.416854101021;6827.761028364082;6828.9317106829285;7024.121984751906;7039.542429742153;7051.682674279669;4343.869683909487;4443.334748196075;4465.575770301816;4504.932426013613;4596.931046034312;1605.4199135926715;1694.635653334539;1777.4045694692165;1802.6935420978466;1824.2016024863642;796.3828033274143;864.4251572704081;871.3116637856023;881.3037700216757;921.8571121476182;15642.765358519631;16004;16113.919430403008;16719.414820481226;17603.55991100233;813.9877901831477;816.6937398475571;822.1696086952102;844.8437039147655;923.2844545477309;9572.138507534217;10036.949815250877;10043.296969212084;10120.696379108638;10171.186305095574;395057;399680;417218;418047;418955;75899;76883;77280.61359693165;78031;78062;796.1799346672937;821.2280456370992;824.2499325613662;836;836.8200836820113;11778.352190629597;15573.610659733597;16496.587585309982;16613.169341532634;16666.333346665997;35205.82397087998;37141.442878356305;37437;37892.43161352637;38825.223495530496;46870.76564617155;47636.52363476321;48149.27776083432;48429.273560897316;48621.5137848617;6568.967155164193;7001.194862590867;7630.236976302325;7690.692372305045;8078.3133433658795;8379.413441059067;12584.307863067253;12764.04269679759;12886.48454061827;13004.739905202032;10141.645042423479;10426.322289051188;10825.729356766144;10930.344179348946;11146.609868654557;9883.406995580288;10957.726056848642;10983.121350292116;11189.776204476027;11304.547818087185;10474.738131546772;10579.523921423708;10823.242373033812;11078.723031924266;11142.554297828321;7088.0785497884945;7139.82150446243;7263.201047884623;7291.489595728248;7885.369170466463;9014.549272536478;10466.738331541772;10701.51843167075;10707;11223.71940701489 17:16:46 INFO - PROCESS | 3818 | |3;mootools.html;1370.1915869636916;1427.785832125181;1486.8438813924538;1645.2431881334585;1701.923413446394;7161.641917904103;7750.806229844256;7751.6124193790365;7752.534847909129;7754.991851059362;6200.78297259596;6407;6410.1987251593555;6556.901646475307;7614.086309642837;1775.3519965212733;2027.3715148304;2097.947551311222;2100.432883121556;2123.936281911545;2072.5902419674703;2096.5073207796154;2100.9579808403823;2104.2635077722825;2104.905279262437;2005.4084045206698;2012.034223572686;2013.4161093283003;2018.2734215682342;2018.6669199582052;1962.2739586352998;1968.389799162257;1975.1901720294754;2007.6085163393145;2013.0438041930113;2059.268959519364;2060.783617720133;2061.1240222905353;2068.338131797825;2068.369147410039;7623.61881905908;7670.002899623069;7682.692692292301;7687.538747675101;7739.767806965744;4456.952616135206;4585.793639286207;4595.724256544585;4601.240795268776;4606.769661516911;2767.4741799058315;2822.788290878192;2843.3176037750995;2849.9287517812013;2856.11460447262;838.8825564420986;845.336410917433;846.7967687754956;884.0849720539211;889.470764894893;10568.577256909715;10570.20723445737;10594.099501542301;10599.0990765785;10614.78770424595;3833.9808300958875;4002.199560087994;4161.958380416218;4196.727212731163;4204.07510347723;9007.594658240396;9008.684696035607;9010.053944335881;9014.323925705598;9014.909850901407;4607.792649330788;4616.907661846744;4618.630509559227;4620.306953956866;4622.791974361162;4186.68599855006;4214.789260536961;4218.578142185757;4225.492940847118;4225.619694227535;3454.4300190468293;3521.3837578424186;3577.731670124699;3577.982110089485;3632.4914511968345;1115.5649296774266;1155.8728539860608;1169.6432588060723;1170.4089434835523;1173.7359094203737;743.3347154296874;807.6163822184416;811.4360519438933;816.3387655998661;822.6133717152928;5049.697018178921;5192.688438693691;5219;5257.106291930381;5309.36287645485;387.5020598530874;396.8710169195023;401.9095703466697;871.5903525343206;964.3153361113688;3716.1824398632257;3911.4915061041884;3975.8807235782974;4015.959840401617;4046.291898917678;9528.333016688905;9642.228621710246;9748.707538773848;9752.561134748954;9778.608855645694;9357.39176953496;9621.9037809621;9635.373700709571;9714.12572868431;9824.45965471906;7325.706971721072;7518.511296765692;7526.736564220226;7529.774106776696;7535.13345965221;5453.509184173285;5493.670379777226;5527.2538207341495;5578.107502799533;5675.801346952837;8857.734267971971;8872.068432814462;9013.233875120688;9055.230305424113;9074.863877041982;8777.561121943749;9127.132922372364;9137.634494620406;9204.401713888576;9304.209142222986;5542.916856247079;6241.31345551998;6378.266499352634;6462.3537646235;6463.224413070461;7079.752208672672;7144.4998850082075;7149.106361704787;7150.249223831631;7156.785296441115;6295.401936815995;6329.7151628175925;6359.523035772243;6385.936140638534;6566.606003639797;6336.493080553637;6380.840478987877;6388.329225431263;6425.5502114851515;6529.249136349381;6171.783987560414;6272.96496078142;6281.52888533371;6294.716737746904;6298.842528936813;4376.518582955809;4494.640428765625;4521.728696278234;4597.03462272913;4618.861434156981;4456.598906098467;4528.524504926935;4613.123506533748;4732.597729193058;4799.680087975835 17:16:46 INFO - PROCESS | 3818 | |4;prototype.html;291.0424702728025;294.7833342493267;297.13978033592764;297.82130721567063;303.90730827097724;4811.615070794337;4813.422389313288;4831.275308703692;4854.22820670455;4881.755912204393;4799.64002699798;4799.856004319876;4814.879628009301;4821.493743156971;4826.589739872106;3578.677918987284;3640.908977275563;3687.9489345536526;3693.556773187221;3778.8677396291137;3747.707041070826;3749.137698329386;3749.625037496256;3765.548134223897;3780.924381512368;3729.8694545690905;3732;3734.1142722924883;3735.3463143949834;3745.644163804448;3555.964440355602;3581.6239294874053;3717.1636381814146;3729.4219395993664;3731.9626803731885;3251.203455153479;3253.902382928516;3261.3640340133684;3263.755218358609;3282.3927573398996;4691.929621055687;4708.858734237979;4713.387259656257;4736.928946065812;4756.693003893109;4149.813258403379;4274.487061552602;4277.401163837066;4280.122574872144;4306.35404689296;5000.449680726689;5007.39911210657;5019.949800501985;5024.070546948826;5055.241713742931;3604.5854726706502;3606.5131207287204;3609.27814437111;3625;3634.6547078027547;5055.443901170868;5318.308619879391;5322.547583455411;5327.893442131136;5330.307060082203;3638.1814091829656;3641.6540428659237;3644.0889777555612;3646.9817650912105;3653.7211975808254;3696.7819308414737;3712.925741485209;3716.554013518395;3728.4034554471154;3736.412024889411;4259.1268789897995;4272.679549033773;4278.229918614679;4278.828846846091;4284.2930916398445;4774.355462012653;4998.150314446553;5019.920717045779;5116.692998420107;5128.794848206105;1273.8598754137038;1283.890869276122;1289.3875409180564;1289.9097063205672;1292.6315999939973;795.5226863881625;817.721974528663;824.6536454689045;839.6347588798892;839.6641343462663;4242.257604919127;4343.370211319341;4364.8472303469225;4385.254506733863;4391.494978077562;5109.718965456936;5126.69239845603;5157.220758838195;5186.740662966837;5197.766100525486;4405.933910991338;4440.4227450431235;4444.400005999149;4465.843695470708;4474.821007159742;2640.392709676785;2709.6477457930737;2728.6589176352954;2735.849528275924;2736.616873637692;4884.780184891617;4884.902301953941;4886.755662216946;4903.141950158779;4907.460179380265;5128.282040514331;5269.262303277545;5297.331340627767;5301.734913254322;5320.467953204726;4835.734034628059;4839.128956787742;4857.684250523705;4858.416989961227;4886.144924638174;5111.207762796773;5125.333706618116;5130.820421285237;5155.561777248976;5167.328247327823;4897.681650692693;5047.6214283929585;5049.823256186016;5071.112555302881;5088.313077734459;4886.731229782396;4891.951080489292;4900.975495122501;4915.738760170361;4929.802807887644;3574.5531808523933;3576.213233088716;3580.7135429165082;3600.7839529628304;3609.6209897961385;4992.2511623256805;5152.690838549699;5179.48205179479;5183.533481986639;5255.710935898409;4998.975005125097;5013.974930125326;5029.899402011866;5032.144535429059;5055.69665820052;5011.84964451067;5019.899602008012;5023.538466151633;5031.874203144951;5046.9747651261505;4718;4937.802487900443;4955.281484184845;4959.256111583291;4986.451490336132;4848.327327072155;4914.483979182278;5045.84862454127;5082.517160869711;5092.185250360073;4948.134076536664;4959.280904268933;4973.229149481836;4973.776180071833;4981.875453113701 17:16:46 INFO - PROCESS | 3818 | |5;yui.html;529.7166016181344;531.8271561742432;534.5135926307062;538.1792766031801;569.313976658127;11383.430828458575;12833.679158021054;12837.29394883281;12843.614691559256;12853.935730321358;11890.346030968294;12891.419886105125;13040.73918521629;13068.803967940488;13085.93457032716;753.2881427051425;780.2587541835251;781.6248200863589;781.7615627233691;781.86708259596;767.0603510699405;772.2046292318893;773.4315278270467;774.0595176860114;775.2325198053915;820.7209548753423;822.3503432288485;822.4859462835727;823.172711425017;823.2631794543879;816.2653611749414;816.7590560784553;816.9591520423985;817.7015389382892;818.0551463060175;600.2227115884896;600.4775845014865;600.5435868739745;600.8828278485697;601.0473399661498;10555.525001374957;10577.418241996687;10590.152787776959;10623.468826558641;10630.246009408438;9966.950165249127;10067.89932100677;10153.441560714158;10249.692509224735;10882.673519794418;8860.955695221546;9044.412113212686;9178.173964343241;9386.765330866783;9488.051194880525;3118.3607360491046;3126.093432904455;3142.261568531393;3170.936581268385;3239.093053944899;61521.38478615201;62978.68510657417;63650.045249321294;63880;64763.3523664762;7622.237776222333;7879.6848126075465;7891.802704932308;7899.802504937423;8116.472429292077;16630.251638676287;16805.663886722195;16829.747553786703;16888.40890568824;17153.485395438158;6203.193584833943;6221.097940798559;6280.905786413207;6283.96858015707;6295.370462953668;3558.3417067842533;3597.388443964532;3597.730170237243;3603.4234522476277;3629.564452265745;2670.305720512642;2781.1100447856493;3037.39252149571;3185.490321548541;3189.489681650925;519.187471606934;520.7630528109701;522.9372475302912;524.8294304351101;541.0234526679382;429.83236537750304;500.3720330984591;540.1115165552644;556.4796914884596;560.7700842654574;7399.334059934524;7952.920470795334;8015.559144247006;8197.71308004229;8215.630296636666;545.7135004122788;550.7218854478463;552.8528303769614;566.7166416791604;575.602834044508;3762.9247415051545;3884.126071633916;3954.7429417087797;4095.4266402703647;4098.118904435561;59723.701381492814;95261;106158.46920765347;108214.45892770485;109809;51877.481225187264;67381;87975.56012219898;93702.53148734213;94494.52752736192;73112;74878;77524.61237693776;84033.57983210168;84703.57648211843;7789.883151752615;8067.798305042421;8358.164183581594;8454.957725211334;8504.702335418231;30485.847570762005;31032.53451198189;37905.05237369088;41898.58101418947;42023.3696494559;54989.450105498436;56223;61569.38430615637;64048.67975660092;66086.33913660994;9403.247740180906;9926.751831204278;9962.252831037556;10001.249906256915;10053.899461005589;10988.945055274993;11139.273412621056;11238.381888996184;11415.486303116213;11545.422728863356;10695.839562406414;11054;11167.832482512931;11180.161487888603;11196.328220306808;10356.948215258875;10793.406362649815;10912.236143470198;11591;11593.768124637629;10809.891901080888;10887.292325998786;11213.271137376045;11405.657830265105;11421.714457138638;9281.72154835356;9371.625134994796;9472.57373418184;9784.804303914025;9815.656452024145;9369.765755856159;9658.227341812497;9723.367981081206;9732.70801875945;9899.65351212704 17:16:46 INFO - PROCESS | 3818 | __end_tp_report 17:16:46 INFO - PROCESS | 3818 | __start_cc_report 17:16:46 INFO - PROCESS | 3818 | _x_x_mozilla_cycle_collect,999 17:16:46 INFO - PROCESS | 3818 | __end_cc_report 17:16:46 INFO - PROCESS | 3818 | __startTimestamp1470615406631__endTimestamp 17:16:46 INFO - PROCESS | 3818 | 17:16:46 INFO - PROCESS | 3818 | ------- Summary: start ------- 17:16:46 INFO - PROCESS | 3818 | Number of tests: 6 17:16:46 INFO - PROCESS | 3818 | 17:16:46 INFO - PROCESS | 3818 | [#0] dojo.html Cycles:165 Average:4752.68 Median:4875.95 stddev:503.48 (10.3%) stddev-sans-first:476.72 17:16:46 INFO - PROCESS | 3818 | Values: 2630.7 2638.1 2640.2 2673.2 2682.7 4507.0 4603.7 4722.4 4838.7 4844.3 4806.3 4828.5 4840.5 4876.0 4885.0 4286.1 4414.9 4493.7 4550.6 4592.5 4507.1 4535.4 4553.7 4564.8 4568.0 4258.7 4289.3 4310.7 4390.5 4422.4 4399.3 4404.6 4420.6 4439.9 4527.2 4436.1 4437.9 4441.6 4474.4 4475.2 4540.1 4720.6 4839.0 4887.8 4898.3 5104.6 5144.5 5197.4 5205.8 5206.2 5176.8 5189.9 5221.8 5248.7 5251.4 4592.0 4744.0 4803.2 4868.3 4871.3 5275.9 5278.5 5307.9 5309.9 5327.6 5055.7 5093.6 5094.4 5106.4 5113.4 4898.3 5063.3 5108.1 5195.9 5199.6 5104.6 5106.3 5107.4 5147.8 5152.8 5033.7 5042.1 5043.1 5079.2 5095.2 4147.0 4180.5 4336.7 4368.8 4411.6 3812.4 3835.0 3875.9 3912.0 3933.6 4460.7 4461.8 4465.6 4467.0 4513.1 4919.5 4994.3 5238.7 5240.2 5264.8 4350.7 4395.8 4400.7 4412.0 4459.4 4613.6 4641.4 4644.1 4648.3 4703.0 4630.7 4793.0 4829.6 4844.1 4892.2 5126.3 5176.8 5189.5 5201.5 5216.8 4846.4 4850.6 4855.4 4858.1 4894.5 4816.7 5096.6 5102.4 5105.4 5160.9 4917.7 5107.8 5129.4 5141.1 5230.8 5025.2 5040.5 5042.0 5047.5 5101.3 5026.4 5031.7 5033.2 5038.5 5038.8 4725.3 4878.0 4949.7 4955.6 5028.5 5053.5 5061.3 5068.9 5074.9 5115.6 4656.3 4949.4 4951.5 4955.4 4956.0 17:16:46 INFO - PROCESS | 3818 | 17:16:46 INFO - PROCESS | 3818 | [#1] ext.html Cycles:180 Average:46123.42 Median:36150.50 stddev:80738.20 (223.3%) stddev-sans-first:80892.19 17:16:46 INFO - PROCESS | 3818 | Values: 551.3 573.0 583.6 589.8 597.0 38235.4 39267.2 39300.0 39425.2 43458.8 41844.0 42279.6 42351.2 42398.8 42446.6 7299.1 7697.6 7905.2 7917.4 9827.2 9659.0 10048.8 10052.8 10053.4 10054.0 10066.6 10146.9 10153.9 10159.9 10174.2 10003.4 10058.4 10089.1 10091.4 10095.0 9863.3 9936.0 9937.9 9938.1 9942.4 39597.4 39929.8 40015.8 40037.8 40088.8 2752.1 2754.2 2886.6 2935.5 3210.0 29258.4 29579.0 29780.4 30104.2 30484.7 3422.8 3436.9 3454.6 3486.3 3487.7 259505.0 261940.0 262119.0 262415.0 262625.0 53743.0 54110.0 54154.0 54228.7 54251.7 32940.3 33903.7 34043.7 35447.3 35672.1 13574.9 13727.2 13759.5 13760.7 13760.8 9031.6 9181.1 9203.2 9433.2 10300.1 16315.5 17679.6 17767.4 18154.2 18656.3 6558.2 6665.1 6690.5 6768.6 6825.6 828.4 862.8 934.2 956.6 993.0 26726.5 27903.2 28516.6 28644.4 28660.0 797.4 822.8 848.7 898.8 926.4 14744.8 15002.3 15277.8 15427.4 15458.9 373051.0 377901.0 378547.0 379305.0 379658.0 50398.0 50921.0 50983.2 51039.2 51090.5 1076.1 1085.7 1089.4 1165.3 1171.8 22167.4 28564.3 29074.7 29626.4 29662.6 46884.3 47448.5 47522.8 47536.0 47539.0 268052.0 269509.0 269982.0 270091.0 270751.0 22786.0 23557.6 25646.2 25811.7 26192.7 45238.0 45337.3 46180.0 46270.8 46719.5 36473.3 36540.8 36789.4 37226.0 37617.2 36984.8 37103.8 37435.6 37486.8 37617.6 35965.0 36336.0 36792.4 37150.6 37464.0 28469.6 30613.5 30673.0 30746.2 30910.0 23653.6 23673.0 23795.5 24038.5 24107.3 17:16:46 INFO - PROCESS | 3818 | 17:16:46 INFO - PROCESS | 3818 | [#2] jquery.html Cycles:180 Average:24927.49 Median:397368.50 stddev:67507.46 (17.0%) stddev-sans-first:67671.63 17:16:46 INFO - PROCESS | 3818 | Values: 360.5 363.7 371.4 372.9 375.7 16643.9 17029.4 17170.7 17256.2 17259.7 16651.9 17109.6 17441.2 17567.4 17630.8 4856.2 5097.2 5100.2 5101.8 5101.8 3749.1 3939.1 5011.6 5633.5 5888.1 5942.0 5952.0 5956.1 5957.4 5957.8 5711.6 5861.8 5899.5 5905.0 5908.5 5049.2 5190.1 5195.0 5199.1 5200.0 20676.8 21112.9 21192.5 21341.3 21388.0 1788.2 1888.2 1918.1 1927.8 1970.7 9193.0 9602.8 9719.0 12628.1 13096.6 1643.3 1669.2 1727.7 1808.5 1812.3 66790.0 69118.7 69168.8 69605.0 69991.3 10174.7 10198.3 10355.7 10398.5 10404.4 14367.7 14368.1 14374.9 14388.1 14388.4 7168.9 7313.3 7320.9 7361.7 7380.4 6827.8 6828.9 7024.1 7039.5 7051.7 4343.9 4443.3 4465.6 4504.9 4596.9 1605.4 1694.6 1777.4 1802.7 1824.2 796.4 864.4 871.3 881.3 921.9 15642.8 16004.0 16113.9 16719.4 17603.6 814.0 816.7 822.2 844.8 923.3 9572.1 10036.9 10043.3 10120.7 10171.2 395057.0 399680.0 417218.0 418047.0 418955.0 75899.0 76883.0 77280.6 78031.0 78062.0 796.2 821.2 824.2 836.0 836.8 11778.4 15573.6 16496.6 16613.2 16666.3 35205.8 37141.4 37437.0 37892.4 38825.2 46870.8 47636.5 48149.3 48429.3 48621.5 6569.0 7001.2 7630.2 7690.7 8078.3 8379.4 12584.3 12764.0 12886.5 13004.7 10141.6 10426.3 10825.7 10930.3 11146.6 9883.4 10957.7 10983.1 11189.8 11304.5 10474.7 10579.5 10823.2 11078.7 11142.6 7088.1 7139.8 7263.2 7291.5 7885.4 9014.5 10466.7 10701.5 10707.0 11223.7 17:16:46 INFO - PROCESS | 3818 | 17:16:46 INFO - PROCESS | 3818 | [#3] mootools.html Cycles:180 Average:5046.92 Median:5238.05 stddev:2865.41 (54.7%) stddev-sans-first:2860.13 17:16:46 INFO - PROCESS | 3818 | Values: 1370.2 1427.8 1486.8 1645.2 1701.9 7161.6 7750.8 7751.6 7752.5 7755.0 6200.8 6407.0 6410.2 6556.9 7614.1 1775.4 2027.4 2097.9 2100.4 2123.9 2072.6 2096.5 2101.0 2104.3 2104.9 2005.4 2012.0 2013.4 2018.3 2018.7 1962.3 1968.4 1975.2 2007.6 2013.0 2059.3 2060.8 2061.1 2068.3 2068.4 7623.6 7670.0 7682.7 7687.5 7739.8 4457.0 4585.8 4595.7 4601.2 4606.8 2767.5 2822.8 2843.3 2849.9 2856.1 838.9 845.3 846.8 884.1 889.5 10568.6 10570.2 10594.1 10599.1 10614.8 3834.0 4002.2 4162.0 4196.7 4204.1 9007.6 9008.7 9010.1 9014.3 9014.9 4607.8 4616.9 4618.6 4620.3 4622.8 4186.7 4214.8 4218.6 4225.5 4225.6 3454.4 3521.4 3577.7 3578.0 3632.5 1115.6 1155.9 1169.6 1170.4 1173.7 743.3 807.6 811.4 816.3 822.6 5049.7 5192.7 5219.0 5257.1 5309.4 387.5 396.9 401.9 871.6 964.3 3716.2 3911.5 3975.9 4016.0 4046.3 9528.3 9642.2 9748.7 9752.6 9778.6 9357.4 9621.9 9635.4 9714.1 9824.5 7325.7 7518.5 7526.7 7529.8 7535.1 5453.5 5493.7 5527.3 5578.1 5675.8 8857.7 8872.1 9013.2 9055.2 9074.9 8777.6 9127.1 9137.6 9204.4 9304.2 5542.9 6241.3 6378.3 6462.4 6463.2 7079.8 7144.5 7149.1 7150.2 7156.8 6295.4 6329.7 6359.5 6385.9 6566.6 6336.5 6380.8 6388.3 6425.6 6529.2 6171.8 6273.0 6281.5 6294.7 6298.8 4376.5 4494.6 4521.7 4597.0 4618.9 4456.6 4528.5 4613.1 4732.6 4799.7 17:16:46 INFO - PROCESS | 3818 | 17:16:46 INFO - PROCESS | 3818 | [#4] prototype.html Cycles:180 Average:4169.42 Median:4814.15 stddev:1218.49 (25.3%) stddev-sans-first:1186.63 17:16:46 INFO - PROCESS | 3818 | Values: 291.0 294.8 297.1 297.8 303.9 4811.6 4813.4 4831.3 4854.2 4881.8 4799.6 4799.9 4814.9 4821.5 4826.6 3578.7 3640.9 3687.9 3693.6 3778.9 3747.7 3749.1 3749.6 3765.5 3780.9 3729.9 3732.0 3734.1 3735.3 3745.6 3556.0 3581.6 3717.2 3729.4 3732.0 3251.2 3253.9 3261.4 3263.8 3282.4 4691.9 4708.9 4713.4 4736.9 4756.7 4149.8 4274.5 4277.4 4280.1 4306.4 5000.4 5007.4 5019.9 5024.1 5055.2 3604.6 3606.5 3609.3 3625.0 3634.7 5055.4 5318.3 5322.5 5327.9 5330.3 3638.2 3641.7 3644.1 3647.0 3653.7 3696.8 3712.9 3716.6 3728.4 3736.4 4259.1 4272.7 4278.2 4278.8 4284.3 4774.4 4998.2 5019.9 5116.7 5128.8 1273.9 1283.9 1289.4 1289.9 1292.6 795.5 817.7 824.7 839.6 839.7 4242.3 4343.4 4364.8 4385.3 4391.5 5109.7 5126.7 5157.2 5186.7 5197.8 4405.9 4440.4 4444.4 4465.8 4474.8 2640.4 2709.6 2728.7 2735.8 2736.6 4884.8 4884.9 4886.8 4903.1 4907.5 5128.3 5269.3 5297.3 5301.7 5320.5 4835.7 4839.1 4857.7 4858.4 4886.1 5111.2 5125.3 5130.8 5155.6 5167.3 4897.7 5047.6 5049.8 5071.1 5088.3 4886.7 4892.0 4901.0 4915.7 4929.8 3574.6 3576.2 3580.7 3600.8 3609.6 4992.3 5152.7 5179.5 5183.5 5255.7 4999.0 5014.0 5029.9 5032.1 5055.7 5011.8 5019.9 5023.5 5031.9 5047.0 4718.0 4937.8 4955.3 4959.3 4986.5 4848.3 4914.5 5045.8 5082.5 5092.2 4948.1 4959.3 4973.2 4973.8 4981.9 17:16:46 INFO - PROCESS | 3818 | 17:16:46 INFO - PROCESS | 3818 | [#5] yui.html Cycles:180 Average:16950.05 Median:554.67 stddev:25354.58 (4571.1%) stddev-sans-first:25395.73 17:16:46 INFO - PROCESS | 3818 | Values: 529.7 531.8 534.5 538.2 569.3 11383.4 12833.7 12837.3 12843.6 12853.9 11890.3 12891.4 13040.7 13068.8 13085.9 753.3 780.3 781.6 781.8 781.9 767.1 772.2 773.4 774.1 775.2 820.7 822.4 822.5 823.2 823.3 816.3 816.8 817.0 817.7 818.1 600.2 600.5 600.5 600.9 601.0 10555.5 10577.4 10590.2 10623.5 10630.2 9967.0 10067.9 10153.4 10249.7 10882.7 8861.0 9044.4 9178.2 9386.8 9488.1 3118.4 3126.1 3142.3 3170.9 3239.1 61521.4 62978.7 63650.0 63880.0 64763.4 7622.2 7879.7 7891.8 7899.8 8116.5 16630.3 16805.7 16829.7 16888.4 17153.5 6203.2 6221.1 6280.9 6284.0 6295.4 3558.3 3597.4 3597.7 3603.4 3629.6 2670.3 2781.1 3037.4 3185.5 3189.5 519.2 520.8 522.9 524.8 541.0 429.8 500.4 540.1 556.5 560.8 7399.3 7952.9 8015.6 8197.7 8215.6 545.7 550.7 552.9 566.7 575.6 3762.9 3884.1 3954.7 4095.4 4098.1 59723.7 95261.0 106158.5 108214.5 109809.0 51877.5 67381.0 87975.6 93702.5 94494.5 73112.0 74878.0 77524.6 84033.6 84703.6 7789.9 8067.8 8358.2 8455.0 8504.7 30485.8 31032.5 37905.1 41898.6 42023.4 54989.5 56223.0 61569.4 64048.7 66086.3 9403.2 9926.8 9962.3 10001.2 10053.9 10988.9 11139.3 11238.4 11415.5 11545.4 10695.8 11054.0 11167.8 11180.2 11196.3 10356.9 10793.4 10912.2 11591.0 11593.8 10809.9 10887.3 11213.3 11405.7 11421.7 9281.7 9371.6 9472.6 9784.8 9815.7 9369.8 9658.2 9723.4 9732.7 9899.7 17:16:46 INFO - PROCESS | 3818 | -------- Summary: end -------- 17:16:46 INFO - PROCESS | 3818 | 17:16:47 INFO - TEST-INFO | 3818: exit 0 17:16:47 INFO - TEST-OK | dromaeo_css | took 1119657ms 17:16:47 INFO - TEST-START | kraken 17:16:47 INFO - operating with platform_type : linux_ 17:16:47 INFO - Initialising browser for kraken test... 17:16:47 INFO - TEST-INFO | started process 4005 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0qI97X/profile http://localhost:34341/getInfo.html) 17:16:51 INFO - PROCESS | 4005 | __metrics Screen width/height:1600/1200 17:16:51 INFO - PROCESS | 4005 | colorDepth:24 17:16:51 INFO - PROCESS | 4005 | Browser inner width/height: 1024/697 17:16:51 INFO - PROCESS | 4005 | __metrics 17:16:52 INFO - PROCESS | 4005 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:16:52 INFO - PROCESS | 4005 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:16:53 INFO - TEST-INFO | 4005: exit 0 17:16:53 INFO - Browser initialized. 17:16:53 INFO - Running cycle 1/1 for kraken test... 17:16:53 INFO - TEST-INFO | started process 4084 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0qI97X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:17:05 INFO - PROCESS | 4084 | RSS: Main: 158048256 17:17:05 INFO - PROCESS | 4084 | 17:17:07 INFO - PROCESS | 4084 | Cycle 1(1): loaded http://localhost:34341/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34341/tests/kraken/driver.html?testName=audio-beat-detection) 17:17:08 INFO - PROCESS | 4084 | RSS: Main: 213573632 17:17:08 INFO - PROCESS | 4084 | 17:17:11 INFO - PROCESS | 4084 | Cycle 1(1): loaded http://localhost:34341/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34341/tests/kraken/driver.html?testName=audio-dft) 17:17:12 INFO - PROCESS | 4084 | RSS: Main: 192733184 17:17:12 INFO - PROCESS | 4084 | 17:17:15 INFO - PROCESS | 4084 | Cycle 1(1): loaded http://localhost:34341/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34341/tests/kraken/driver.html?testName=audio-fft) 17:17:16 INFO - PROCESS | 4084 | RSS: Main: 271802368 17:17:16 INFO - PROCESS | 4084 | 17:17:18 INFO - PROCESS | 4084 | Cycle 1(1): loaded http://localhost:34341/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34341/tests/kraken/driver.html?testName=audio-oscillator) 17:17:18 INFO - PROCESS | 4084 | RSS: Main: 180195328 17:17:18 INFO - PROCESS | 4084 | 17:17:21 INFO - PROCESS | 4084 | Cycle 1(1): loaded http://localhost:34341/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34341/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:17:21 INFO - PROCESS | 4084 | RSS: Main: 185511936 17:17:21 INFO - PROCESS | 4084 | 17:17:24 INFO - PROCESS | 4084 | Cycle 1(1): loaded http://localhost:34341/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34341/tests/kraken/driver.html?testName=imaging-darkroom) 17:17:25 INFO - PROCESS | 4084 | RSS: Main: 221298688 17:17:25 INFO - PROCESS | 4084 | 17:17:29 INFO - PROCESS | 4084 | Cycle 1(1): loaded http://localhost:34341/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34341/tests/kraken/driver.html?testName=imaging-desaturate) 17:17:29 INFO - PROCESS | 4084 | RSS: Main: 214880256 17:17:29 INFO - PROCESS | 4084 | 17:17:32 INFO - PROCESS | 4084 | Cycle 1(1): loaded http://localhost:34341/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34341/tests/kraken/driver.html?testName=json-parse-financial) 17:17:33 INFO - PROCESS | 4084 | RSS: Main: 218775552 17:17:33 INFO - PROCESS | 4084 | 17:17:34 INFO - PROCESS | 4084 | Cycle 1(1): loaded http://localhost:34341/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34341/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:17:35 INFO - PROCESS | 4084 | RSS: Main: 184385536 17:17:35 INFO - PROCESS | 4084 | 17:17:37 INFO - PROCESS | 4084 | Cycle 1(1): loaded http://localhost:34341/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34341/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:17:38 INFO - PROCESS | 4084 | RSS: Main: 188956672 17:17:38 INFO - PROCESS | 4084 | 17:17:40 INFO - PROCESS | 4084 | Cycle 1(1): loaded http://localhost:34341/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34341/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:17:40 INFO - PROCESS | 4084 | RSS: Main: 194056192 17:17:40 INFO - PROCESS | 4084 | 17:17:43 INFO - PROCESS | 4084 | Cycle 1(1): loaded http://localhost:34341/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34341/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:17:44 INFO - PROCESS | 4084 | RSS: Main: 189755392 17:17:44 INFO - PROCESS | 4084 | 17:17:47 INFO - PROCESS | 4084 | Cycle 1(1): loaded http://localhost:34341/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34341/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:17:47 INFO - PROCESS | 4084 | RSS: Main: 192745472 17:17:47 INFO - PROCESS | 4084 | 17:17:49 INFO - PROCESS | 4084 | Cycle 1(1): loaded http://localhost:34341/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34341/tests/kraken/driver.html?testName=ai-astar) 17:17:49 INFO - PROCESS | 4084 | RSS: Main: 243068928 17:17:49 INFO - PROCESS | 4084 | 17:17:49 INFO - PROCESS | 4084 | __start_tp_report 17:17:49 INFO - PROCESS | 4084 | _x_x_mozilla_page_load 17:17:49 INFO - PROCESS | 4084 | _x_x_mozilla_page_load_details 17:17:49 INFO - PROCESS | 4084 | |i|pagename|runs| 17:17:49 INFO - PROCESS | 4084 | |0;ai-astar;104;116;114;114;116;115;113;114;116;114 17:17:49 INFO - PROCESS | 4084 | |1;audio-beat-detection;149;121;124;174;128;124;153;124;179;121 17:17:49 INFO - PROCESS | 4084 | |2;audio-dft;164;163;162;163;162;163;161;161;163;163 17:17:49 INFO - PROCESS | 4084 | |3;audio-fft;75;75;74;118;76;75;75;76;119;75 17:17:49 INFO - PROCESS | 4084 | |4;audio-oscillator;86;85;121;85;86;85;129;85;84;133 17:17:49 INFO - PROCESS | 4084 | |5;imaging-gaussian-blur;117;118;116;117;117;117;118;116;117;117 17:17:49 INFO - PROCESS | 4084 | |6;imaging-darkroom;146;147;147;147;146;147;147;147;146;146 17:17:49 INFO - PROCESS | 4084 | |7;imaging-desaturate;95;94;95;94;95;95;95;94;95;94 17:17:49 INFO - PROCESS | 4084 | |8;json-parse-financial;73;64;62;61;63;62;62;62;62;62 17:17:49 INFO - PROCESS | 4084 | |9;json-stringify-tinderbox;66;67;65;65;67;65;70;66;66;65 17:17:49 INFO - PROCESS | 4084 | |10;stanford-crypto-aes;79;80;79;79;80;78;78;82;79;80 17:17:49 INFO - PROCESS | 4084 | |11;stanford-crypto-ccm;141;131;129;132;128;130;129;132;167;130 17:17:49 INFO - PROCESS | 4084 | |12;stanford-crypto-pbkdf2;169;166;163;171;165;165;166;168;163;162 17:17:49 INFO - PROCESS | 4084 | |13;stanford-crypto-sha256-iterative;68;70;77;67;70;66;65;66;65;66 17:17:49 INFO - PROCESS | 4084 | __end_tp_report 17:17:49 INFO - PROCESS | 4084 | __start_cc_report 17:17:49 INFO - PROCESS | 4084 | _x_x_mozilla_cycle_collect,1954 17:17:49 INFO - PROCESS | 4084 | __end_cc_report 17:17:49 INFO - PROCESS | 4084 | __startTimestamp1470615469721__endTimestamp 17:17:49 INFO - PROCESS | 4084 | 17:17:49 INFO - PROCESS | 4084 | ------- Summary: start ------- 17:17:49 INFO - PROCESS | 4084 | Number of tests: 14 17:17:49 INFO - PROCESS | 4084 | 17:17:49 INFO - PROCESS | 4084 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.50 stddev:3.53 (3.1%) stddev-sans-first:1.12 17:17:49 INFO - PROCESS | 4084 | Values: 104.0 116.0 114.0 114.0 116.0 115.0 113.0 114.0 116.0 114.0 17:17:49 INFO - PROCESS | 4084 | 17:17:49 INFO - PROCESS | 4084 | [#1] audio-beat-detection Cycles:10 Average:139.70 Median:138.50 stddev:22.51 (16.3%) stddev-sans-first:23.62 17:17:49 INFO - PROCESS | 4084 | Values: 149.0 121.0 124.0 174.0 128.0 124.0 153.0 124.0 179.0 121.0 17:17:49 INFO - PROCESS | 4084 | 17:17:49 INFO - PROCESS | 4084 | [#2] audio-dft Cycles:10 Average:162.50 Median:163.00 stddev:0.97 (0.6%) stddev-sans-first:0.87 17:17:49 INFO - PROCESS | 4084 | Values: 164.0 163.0 162.0 163.0 162.0 163.0 161.0 161.0 163.0 163.0 17:17:49 INFO - PROCESS | 4084 | 17:17:49 INFO - PROCESS | 4084 | [#3] audio-fft Cycles:10 Average:83.80 Median:75.00 stddev:18.30 (24.4%) stddev-sans-first:19.13 17:17:49 INFO - PROCESS | 4084 | Values: 75.0 75.0 74.0 118.0 76.0 75.0 75.0 76.0 119.0 75.0 17:17:49 INFO - PROCESS | 4084 | 17:17:49 INFO - PROCESS | 4084 | [#4] audio-oscillator Cycles:10 Average:97.90 Median:85.00 stddev:20.75 (24.4%) stddev-sans-first:21.56 17:17:49 INFO - PROCESS | 4084 | Values: 86.0 85.0 121.0 85.0 86.0 85.0 129.0 85.0 84.0 133.0 17:17:49 INFO - PROCESS | 4084 | 17:17:49 INFO - PROCESS | 4084 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 17:17:49 INFO - PROCESS | 4084 | Values: 117.0 118.0 116.0 117.0 117.0 117.0 118.0 116.0 117.0 117.0 17:17:49 INFO - PROCESS | 4084 | 17:17:49 INFO - PROCESS | 4084 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 17:17:49 INFO - PROCESS | 4084 | Values: 146.0 147.0 147.0 147.0 146.0 147.0 147.0 147.0 146.0 146.0 17:17:49 INFO - PROCESS | 4084 | 17:17:49 INFO - PROCESS | 4084 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 17:17:49 INFO - PROCESS | 4084 | Values: 95.0 94.0 95.0 94.0 95.0 95.0 95.0 94.0 95.0 94.0 17:17:49 INFO - PROCESS | 4084 | 17:17:49 INFO - PROCESS | 4084 | [#8] json-parse-financial Cycles:10 Average:63.30 Median:62.00 stddev:3.50 (5.6%) stddev-sans-first:0.83 17:17:49 INFO - PROCESS | 4084 | Values: 73.0 64.0 62.0 61.0 63.0 62.0 62.0 62.0 62.0 62.0 17:17:49 INFO - PROCESS | 4084 | 17:17:49 INFO - PROCESS | 4084 | [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:66.00 stddev:1.55 (2.3%) stddev-sans-first:1.64 17:17:49 INFO - PROCESS | 4084 | Values: 66.0 67.0 65.0 65.0 67.0 65.0 70.0 66.0 66.0 65.0 17:17:49 INFO - PROCESS | 4084 | 17:17:49 INFO - PROCESS | 4084 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:79.50 stddev:1.17 (1.5%) stddev-sans-first:1.24 17:17:49 INFO - PROCESS | 4084 | Values: 79.0 80.0 79.0 79.0 80.0 78.0 78.0 82.0 79.0 80.0 17:17:49 INFO - PROCESS | 4084 | 17:17:49 INFO - PROCESS | 4084 | [#11] stanford-crypto-ccm Cycles:10 Average:134.90 Median:131.50 stddev:11.86 (9.0%) stddev-sans-first:12.37 17:17:49 INFO - PROCESS | 4084 | Values: 141.0 131.0 129.0 132.0 128.0 130.0 129.0 132.0 167.0 130.0 17:17:49 INFO - PROCESS | 4084 | 17:17:49 INFO - PROCESS | 4084 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.80 Median:166.00 stddev:2.86 (1.7%) stddev-sans-first:2.79 17:17:49 INFO - PROCESS | 4084 | Values: 169.0 166.0 163.0 171.0 165.0 165.0 166.0 168.0 163.0 162.0 17:17:49 INFO - PROCESS | 4084 | 17:17:49 INFO - PROCESS | 4084 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:67.50 stddev:3.65 (5.4%) stddev-sans-first:3.87 17:17:49 INFO - PROCESS | 4084 | Values: 68.0 70.0 77.0 67.0 70.0 66.0 65.0 66.0 65.0 66.0 17:17:49 INFO - PROCESS | 4084 | -------- Summary: end -------- 17:17:49 INFO - PROCESS | 4084 | 17:17:50 INFO - TEST-INFO | 4084: exit 0 17:17:50 INFO - TEST-OK | kraken | took 63381ms 17:17:50 INFO - SUITE-END | took 1183s 17:17:50 INFO - Completed test suite (00:19:43) 17:17:50 INFO - javascript benchmark 17:17:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2630.723774003729, 2638.076673164392, 2640.221134765244, 2673.238127133766, 2682.745139211774, 4506.977465112678, 4603.677742558022, 4722.437064943491, 4838.733869637169, 4844.321794948705, 4806.255030470274, 4828.51714828517, 4840.491748366424, 4875.951240487594, 4885.0, 4286.1213451242575, 4414.940414300577, 4493.707908985922, 4550.635949124062, 4592.494825569202, 4507.143642707892, 4535.387722657449, 4553.704009239405, 4564.771761411933, 4567.977160114195, 4258.701890867641, 4289.313709806447, 4310.698251122422, 4390.473143222834, 4422.380866678667, 4399.252127138362, 4404.625606823424, 4420.646348292161, 4439.866803995886, 4527.230370836965, 4436.112777444524, 4437.911241775147, 4441.555844415565, 4474.440694913136, 4475.216837053503, 4540.069285796404, 4720.551547603007, 4838.975805120987, 4887.828925987609, 4898.338724272213, 5104.64267501275, 5144.459831717691, 5197.402298735656, 5205.765740541685, 5206.193040078794, 5176.818811341585, 5189.896202075975, 5221.817236396746, 5248.7375631218665, 5251.396089449724, 4591.989762252299, 4743.976280118646, 4803.18345881201, 4868.294097355863, 4871.318015477836, 5275.920861187085, 5278.5249327560705, 5307.893842123136, 5309.946900531023, 5327.627066105335, 5055.69665820052, 5093.567046800989, 5094.414142373675, 5106.361704786902, 5113.41195762492, 4898.314236006961, 5063.3417655704525, 5108.106081435734, 5195.948040519622, 5199.610029247821, 5104.566111880457, 5106.336176297132, 5107.387113546398, 5147.845564633067, 5152.793888244429, 5033.697978121324, 5042.067217564689, 5043.067032598908, 5079.2381142828135, 5095.210242412432, 4147.04617937876, 4180.540140584533, 4336.6530677545725, 4368.825246990148, 4411.647068234533, 3812.4090765931323, 3835.0412396900774, 3875.8837234883, 3911.9608803911597, 3933.6066393360434, 4460.7323560586465, 4461.776911154429, 4465.553444655508, 4467.0, 4513.142502924499, 4919.4834542373255, 4994.275830004629, 5238.659487133325, 5240.240165176028, 5264.789408423697, 4350.717203381833, 4395.846145384896, 4400.713953593006, 4411.977940110279, 4459.420275364247, 4613.630909527297, 4641.419822522184, 4644.140833945731, 4648.349231107648, 4702.976485117552, 4630.7453090079025, 4793.0, 4829.613630909519, 4844.079624871263, 4892.168331383673, 5126.256692779601, 5176.844694659167, 5189.506996835295, 5201.453847345974, 5216.791328346975, 4846.442659094249, 4850.563449289581, 4855.441624213261, 4858.1012512685265, 4894.535019173173, 4816.662833601755, 5096.566791822588, 5102.36220472441, 5105.361829771278, 5160.922586161136, 4917.729524876167, 5107.770150343318, 5129.384473863161, 5141.126008578625, 5230.843074707765, 5025.170846810235, 5040.470750571138, 5042.042012017705, 5047.470015648304, 5101.285819985279, 5026.44709082008, 5031.698098113979, 5033.194688849767, 5038.496150384932, 5038.823641172688, 4725.267583524559, 4877.95122048775, 4949.703017818798, 4955.628327875496, 5028.497150284942, 5053.494650534917, 5061.266116413173, 5068.949310506848, 5074.873128171826, 5115.616328775282, 4656.348111264493, 4949.406071271471, 4951.455339912679, 4955.430125535466, 4956.008798240438], "value": 4720.4083022524155, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.3400102553004, 572.9886749886449, 583.5623282538096, 589.831897909096, 596.9761858412821, 38235.42646860299, 39267.21465570694, 39300.0, 39425.211495770105, 43458.7827060865, 41843.95390115248, 42279.57720422802, 42351.15297694052, 42398.78800606, 42446.57553424472, 7299.124105107395, 7697.615119244029, 7905.249001344863, 7917.366610671133, 9827.213822894188, 9658.9517052415, 10048.799024019516, 10052.849207261861, 10053.396796192215, 10054.0, 10066.647667331645, 10146.898531014705, 10153.898461015406, 10159.898401016006, 10174.236932230075, 10003.449810260432, 10058.446785426799, 10089.142422894063, 10091.39451632897, 10095.0, 9863.260255480796, 9935.950320248425, 9937.900620993842, 9938.10557049869, 9942.353747006422, 39597.40603890944, 39929.80035099835, 40015.79992100021, 40037.79981100105, 40088.79955600233, 2752.119321817019, 2754.2425832895915, 2886.610307608488, 2935.4716151092794, 3210.046071026992, 29258.41483170346, 29579.0, 29780.40439191204, 30104.247393815112, 30484.695153048408, 3422.845971931269, 3436.914077148066, 3454.5943415955526, 3486.337595856779, 3487.7384196185135, 259505.0, 261940.0, 262119.0, 262415.0, 262625.0, 53743.0, 54110.0, 54154.0, 54228.72885635547, 54251.72874135604, 32940.341193176006, 33903.66096339055, 34043.65956340405, 35447.29105417877, 35672.108197295274, 13574.864251357558, 13727.245001524812, 13759.518416855362, 13760.692734190236, 13760.793588096187, 9031.593578288992, 9181.0818918109, 9203.217726493323, 9433.245340372754, 10300.072993430627, 16315.51053468398, 17679.558011049827, 17767.378141765235, 18154.18306176225, 18656.34702785396, 6558.245801732766, 6665.1335326408225, 6690.498212633975, 6768.56004359715, 6825.590464572141, 828.3952714518315, 862.7756783236404, 934.1685899549407, 956.5647630328184, 992.98715310383, 26726.465470690866, 27903.16290511288, 28516.572251416244, 28644.427111457655, 28660.037855141723, 797.3899966525613, 822.8230930349883, 848.7411339541376, 898.7708134425679, 926.4070994563485, 14744.778828317583, 15002.324895379734, 15277.847221527643, 15427.398005888232, 15458.922705386402, 373051.0, 377901.0, 378547.0, 379305.0, 379658.0, 50398.0, 50921.0, 50983.235251471255, 51039.234411483856, 51090.489095108576, 1076.0745758647556, 1085.7014321061456, 1089.4443833644739, 1165.2775279326872, 1171.7890779659572, 22167.391219206365, 28564.285892852844, 29074.7092529072, 29626.407471850875, 29662.555061673662, 46884.29673554967, 47448.52551474441, 47522.762386187846, 47536.0, 47539.0, 268052.0, 269509.0, 269982.0, 270091.0, 270751.0, 22785.974631141307, 23557.646635300825, 25646.230613081636, 25811.741882581686, 26192.73807261979, 45238.0, 45337.31994020158, 46180.0, 46270.76864615655, 46719.532804672875, 36473.27053458863, 36540.817295914414, 36789.44815827818, 37226.0, 37617.2476550462, 36984.815075924445, 37103.81448092742, 37435.62564374322, 37486.812565937, 37617.62382376141, 35965.0, 36336.0, 36792.44811327886, 37150.628493714714, 37464.0, 28469.572956405256, 30613.54079688851, 30673.0, 30746.231344216572, 30910.0, 23653.645195322428, 23673.0, 23795.524089518458, 24038.51922961496, 24107.27678169658], "value": 17654.85005798193, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.4917066935623, 363.66542780641805, 371.3723806766564, 372.86390467479345, 375.7088256601134, 16643.916780416097, 17029.403970861007, 17170.656586868256, 17256.223469943852, 17259.74110388345, 16651.916740416313, 17109.57226069349, 17441.21514531846, 17567.385141520048, 17630.82369176308, 4856.198727210015, 5097.23541468779, 5100.234964755279, 5101.821436249732, 5101.821436249732, 3749.1189570450924, 3939.0546268895546, 5011.599072074226, 5633.549316054706, 5888.146218798272, 5942.0, 5952.047672372421, 5956.136360227764, 5957.374475680056, 5957.761689532414, 5711.571632127586, 5861.765529378819, 5899.46904778572, 5904.9704751475965, 5908.49777768888, 5049.242613607951, 5190.143626301656, 5195.038917800219, 5199.090159222159, 5199.974000129975, 20676.793232067637, 21112.894435527876, 21192.470188245265, 21341.33233345832, 21388.0, 1788.204249109147, 1888.1503323504478, 1918.127252100305, 1927.787943326233, 1970.655135351322, 9192.954035229848, 9602.807943841153, 9719.0, 12628.116031877773, 13096.607101786962, 1643.2523201943088, 1669.240202771478, 1727.723564229717, 1808.4665023817874, 1812.2750899640118, 66790.0, 69118.65440672815, 69168.81233907427, 69604.99542552621, 69991.3000869995, 10174.728158980128, 10198.33710808795, 10355.689329320132, 10398.532066057045, 10404.375737455777, 14367.712645747026, 14368.13791172533, 14374.85625143756, 14388.06477578954, 14388.352524136439, 7168.92831071693, 7313.26867313275, 7320.926790732131, 7361.705531778776, 7380.416854101021, 6827.761028364082, 6828.9317106829285, 7024.121984751906, 7039.542429742153, 7051.682674279669, 4343.869683909487, 4443.334748196075, 4465.575770301816, 4504.932426013613, 4596.931046034312, 1605.4199135926715, 1694.635653334539, 1777.4045694692165, 1802.6935420978466, 1824.2016024863642, 796.3828033274143, 864.4251572704081, 871.3116637856023, 881.3037700216757, 921.8571121476182, 15642.765358519631, 16004.0, 16113.919430403008, 16719.414820481226, 17603.55991100233, 813.9877901831477, 816.6937398475571, 822.1696086952102, 844.8437039147655, 923.2844545477309, 9572.138507534217, 10036.949815250877, 10043.296969212084, 10120.696379108638, 10171.186305095574, 395057.0, 399680.0, 417218.0, 418047.0, 418955.0, 75899.0, 76883.0, 77280.61359693165, 78031.0, 78062.0, 796.1799346672937, 821.2280456370992, 824.2499325613662, 836.0, 836.8200836820113, 11778.352190629597, 15573.610659733597, 16496.587585309982, 16613.169341532634, 16666.333346665997, 35205.82397087998, 37141.442878356305, 37437.0, 37892.43161352637, 38825.223495530496, 46870.76564617155, 47636.52363476321, 48149.27776083432, 48429.273560897316, 48621.5137848617, 6568.967155164193, 7001.194862590867, 7630.236976302325, 7690.692372305045, 8078.3133433658795, 8379.413441059067, 12584.307863067253, 12764.04269679759, 12886.48454061827, 13004.739905202032, 10141.645042423479, 10426.322289051188, 10825.729356766144, 10930.344179348946, 11146.609868654557, 9883.406995580288, 10957.726056848642, 10983.121350292116, 11189.776204476027, 11304.547818087185, 10474.738131546772, 10579.523921423708, 10823.242373033812, 11078.723031924266, 11142.554297828321, 7088.0785497884945, 7139.82150446243, 7263.201047884623, 7291.489595728248, 7885.369170466463, 9014.549272536478, 10466.738331541772, 10701.51843167075, 10707.0, 11223.71940701489], "value": 8270.622397185196, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1370.1915869636916, 1427.785832125181, 1486.8438813924538, 1645.2431881334585, 1701.923413446394, 7161.641917904103, 7750.806229844256, 7751.6124193790365, 7752.534847909129, 7754.991851059362, 6200.78297259596, 6407.0, 6410.1987251593555, 6556.901646475307, 7614.086309642837, 1775.3519965212733, 2027.3715148304, 2097.947551311222, 2100.432883121556, 2123.936281911545, 2072.5902419674703, 2096.5073207796154, 2100.9579808403823, 2104.2635077722825, 2104.905279262437, 2005.4084045206698, 2012.034223572686, 2013.4161093283003, 2018.2734215682342, 2018.6669199582052, 1962.2739586352998, 1968.389799162257, 1975.1901720294754, 2007.6085163393145, 2013.0438041930113, 2059.268959519364, 2060.783617720133, 2061.1240222905353, 2068.338131797825, 2068.369147410039, 7623.61881905908, 7670.002899623069, 7682.692692292301, 7687.538747675101, 7739.767806965744, 4456.952616135206, 4585.793639286207, 4595.724256544585, 4601.240795268776, 4606.769661516911, 2767.4741799058315, 2822.788290878192, 2843.3176037750995, 2849.9287517812013, 2856.11460447262, 838.8825564420986, 845.336410917433, 846.7967687754956, 884.0849720539211, 889.470764894893, 10568.577256909715, 10570.20723445737, 10594.099501542301, 10599.0990765785, 10614.78770424595, 3833.9808300958875, 4002.199560087994, 4161.958380416218, 4196.727212731163, 4204.07510347723, 9007.594658240396, 9008.684696035607, 9010.053944335881, 9014.323925705598, 9014.909850901407, 4607.792649330788, 4616.907661846744, 4618.630509559227, 4620.306953956866, 4622.791974361162, 4186.68599855006, 4214.789260536961, 4218.578142185757, 4225.492940847118, 4225.619694227535, 3454.4300190468293, 3521.3837578424186, 3577.731670124699, 3577.982110089485, 3632.4914511968345, 1115.5649296774266, 1155.8728539860608, 1169.6432588060723, 1170.4089434835523, 1173.7359094203737, 743.3347154296874, 807.6163822184416, 811.4360519438933, 816.3387655998661, 822.6133717152928, 5049.697018178921, 5192.688438693691, 5219.0, 5257.106291930381, 5309.36287645485, 387.5020598530874, 396.8710169195023, 401.9095703466697, 871.5903525343206, 964.3153361113688, 3716.1824398632257, 3911.4915061041884, 3975.8807235782974, 4015.959840401617, 4046.291898917678, 9528.333016688905, 9642.228621710246, 9748.707538773848, 9752.561134748954, 9778.608855645694, 9357.39176953496, 9621.9037809621, 9635.373700709571, 9714.12572868431, 9824.45965471906, 7325.706971721072, 7518.511296765692, 7526.736564220226, 7529.774106776696, 7535.13345965221, 5453.509184173285, 5493.670379777226, 5527.2538207341495, 5578.107502799533, 5675.801346952837, 8857.734267971971, 8872.068432814462, 9013.233875120688, 9055.230305424113, 9074.863877041982, 8777.561121943749, 9127.132922372364, 9137.634494620406, 9204.401713888576, 9304.209142222986, 5542.916856247079, 6241.31345551998, 6378.266499352634, 6462.3537646235, 6463.224413070461, 7079.752208672672, 7144.4998850082075, 7149.106361704787, 7150.249223831631, 7156.785296441115, 6295.401936815995, 6329.7151628175925, 6359.523035772243, 6385.936140638534, 6566.606003639797, 6336.493080553637, 6380.840478987877, 6388.329225431263, 6425.5502114851515, 6529.249136349381, 6171.783987560414, 6272.96496078142, 6281.52888533371, 6294.716737746904, 6298.842528936813, 4376.518582955809, 4494.640428765625, 4521.728696278234, 4597.03462272913, 4618.861434156981, 4456.598906098467, 4528.524504926935, 4613.123506533748, 4732.597729193058, 4799.680087975835], "value": 4014.981946047938, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.0424702728025, 294.7833342493267, 297.13978033592764, 297.82130721567063, 303.90730827097724, 4811.615070794337, 4813.422389313288, 4831.275308703692, 4854.22820670455, 4881.755912204393, 4799.64002699798, 4799.856004319876, 4814.879628009301, 4821.493743156971, 4826.589739872106, 3578.677918987284, 3640.908977275563, 3687.9489345536526, 3693.556773187221, 3778.8677396291137, 3747.707041070826, 3749.137698329386, 3749.625037496256, 3765.548134223897, 3780.924381512368, 3729.8694545690905, 3732.0, 3734.1142722924883, 3735.3463143949834, 3745.644163804448, 3555.964440355602, 3581.6239294874053, 3717.1636381814146, 3729.4219395993664, 3731.9626803731885, 3251.203455153479, 3253.902382928516, 3261.3640340133684, 3263.755218358609, 3282.3927573398996, 4691.929621055687, 4708.858734237979, 4713.387259656257, 4736.928946065812, 4756.693003893109, 4149.813258403379, 4274.487061552602, 4277.401163837066, 4280.122574872144, 4306.35404689296, 5000.449680726689, 5007.39911210657, 5019.949800501985, 5024.070546948826, 5055.241713742931, 3604.5854726706502, 3606.5131207287204, 3609.27814437111, 3625.0, 3634.6547078027547, 5055.443901170868, 5318.308619879391, 5322.547583455411, 5327.893442131136, 5330.307060082203, 3638.1814091829656, 3641.6540428659237, 3644.0889777555612, 3646.9817650912105, 3653.7211975808254, 3696.7819308414737, 3712.925741485209, 3716.554013518395, 3728.4034554471154, 3736.412024889411, 4259.1268789897995, 4272.679549033773, 4278.229918614679, 4278.828846846091, 4284.2930916398445, 4774.355462012653, 4998.150314446553, 5019.920717045779, 5116.692998420107, 5128.794848206105, 1273.8598754137038, 1283.890869276122, 1289.3875409180564, 1289.9097063205672, 1292.6315999939973, 795.5226863881625, 817.721974528663, 824.6536454689045, 839.6347588798892, 839.6641343462663, 4242.257604919127, 4343.370211319341, 4364.8472303469225, 4385.254506733863, 4391.494978077562, 5109.718965456936, 5126.69239845603, 5157.220758838195, 5186.740662966837, 5197.766100525486, 4405.933910991338, 4440.4227450431235, 4444.400005999149, 4465.843695470708, 4474.821007159742, 2640.392709676785, 2709.6477457930737, 2728.6589176352954, 2735.849528275924, 2736.616873637692, 4884.780184891617, 4884.902301953941, 4886.755662216946, 4903.141950158779, 4907.460179380265, 5128.282040514331, 5269.262303277545, 5297.331340627767, 5301.734913254322, 5320.467953204726, 4835.734034628059, 4839.128956787742, 4857.684250523705, 4858.416989961227, 4886.144924638174, 5111.207762796773, 5125.333706618116, 5130.820421285237, 5155.561777248976, 5167.328247327823, 4897.681650692693, 5047.6214283929585, 5049.823256186016, 5071.112555302881, 5088.313077734459, 4886.731229782396, 4891.951080489292, 4900.975495122501, 4915.738760170361, 4929.802807887644, 3574.5531808523933, 3576.213233088716, 3580.7135429165082, 3600.7839529628304, 3609.6209897961385, 4992.2511623256805, 5152.690838549699, 5179.48205179479, 5183.533481986639, 5255.710935898409, 4998.975005125097, 5013.974930125326, 5029.899402011866, 5032.144535429059, 5055.69665820052, 5011.84964451067, 5019.899602008012, 5023.538466151633, 5031.874203144951, 5046.9747651261505, 4718.0, 4937.802487900443, 4955.281484184845, 4959.256111583291, 4986.451490336132, 4848.327327072155, 4914.483979182278, 5045.84862454127, 5082.517160869711, 5092.185250360073, 4948.134076536664, 4959.280904268933, 4973.229149481836, 4973.776180071833, 4981.875453113701], "value": 3780.059465124655, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [529.7166016181344, 531.8271561742432, 534.5135926307062, 538.1792766031801, 569.313976658127, 11383.430828458575, 12833.679158021054, 12837.29394883281, 12843.614691559256, 12853.935730321358, 11890.346030968294, 12891.419886105125, 13040.73918521629, 13068.803967940488, 13085.93457032716, 753.2881427051425, 780.2587541835251, 781.6248200863589, 781.7615627233691, 781.86708259596, 767.0603510699405, 772.2046292318893, 773.4315278270467, 774.0595176860114, 775.2325198053915, 820.7209548753423, 822.3503432288485, 822.4859462835727, 823.172711425017, 823.2631794543879, 816.2653611749414, 816.7590560784553, 816.9591520423985, 817.7015389382892, 818.0551463060175, 600.2227115884896, 600.4775845014865, 600.5435868739745, 600.8828278485697, 601.0473399661498, 10555.525001374957, 10577.418241996687, 10590.152787776959, 10623.468826558641, 10630.246009408438, 9966.950165249127, 10067.89932100677, 10153.441560714158, 10249.692509224735, 10882.673519794418, 8860.955695221546, 9044.412113212686, 9178.173964343241, 9386.765330866783, 9488.051194880525, 3118.3607360491046, 3126.093432904455, 3142.261568531393, 3170.936581268385, 3239.093053944899, 61521.38478615201, 62978.68510657417, 63650.045249321294, 63880.0, 64763.3523664762, 7622.237776222333, 7879.6848126075465, 7891.802704932308, 7899.802504937423, 8116.472429292077, 16630.251638676287, 16805.663886722195, 16829.747553786703, 16888.40890568824, 17153.485395438158, 6203.193584833943, 6221.097940798559, 6280.905786413207, 6283.96858015707, 6295.370462953668, 3558.3417067842533, 3597.388443964532, 3597.730170237243, 3603.4234522476277, 3629.564452265745, 2670.305720512642, 2781.1100447856493, 3037.39252149571, 3185.490321548541, 3189.489681650925, 519.187471606934, 520.7630528109701, 522.9372475302912, 524.8294304351101, 541.0234526679382, 429.83236537750304, 500.3720330984591, 540.1115165552644, 556.4796914884596, 560.7700842654574, 7399.334059934524, 7952.920470795334, 8015.559144247006, 8197.71308004229, 8215.630296636666, 545.7135004122788, 550.7218854478463, 552.8528303769614, 566.7166416791604, 575.602834044508, 3762.9247415051545, 3884.126071633916, 3954.7429417087797, 4095.4266402703647, 4098.118904435561, 59723.701381492814, 95261.0, 106158.46920765347, 108214.45892770485, 109809.0, 51877.481225187264, 67381.0, 87975.56012219898, 93702.53148734213, 94494.52752736192, 73112.0, 74878.0, 77524.61237693776, 84033.57983210168, 84703.57648211843, 7789.883151752615, 8067.798305042421, 8358.164183581594, 8454.957725211334, 8504.702335418231, 30485.847570762005, 31032.53451198189, 37905.05237369088, 41898.58101418947, 42023.3696494559, 54989.450105498436, 56223.0, 61569.38430615637, 64048.67975660092, 66086.33913660994, 9403.247740180906, 9926.751831204278, 9962.252831037556, 10001.249906256915, 10053.899461005589, 10988.945055274993, 11139.273412621056, 11238.381888996184, 11415.486303116213, 11545.422728863356, 10695.839562406414, 11054.0, 11167.832482512931, 11180.161487888603, 11196.328220306808, 10356.948215258875, 10793.406362649815, 10912.236143470198, 11591.0, 11593.768124637629, 10809.891901080888, 10887.292325998786, 11213.271137376045, 11405.657830265105, 11421.714457138638, 9281.72154835356, 9371.625134994796, 9472.57373418184, 9784.804303914025, 9815.656452024145, 9369.765755856159, 9658.227341812497, 9723.367981081206, 9732.70801875945, 9899.65351212704], "value": 6166.674593502996, "unit": "score"}], "name": "dromaeo_css", "value": 6333.022482684685, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 116.0, 114.0, 114.0, 116.0, 115.0, 113.0, 114.0, 116.0, 114.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 121.0, 124.0, 174.0, 128.0, 124.0, 153.0, 124.0, 179.0, 121.0], "value": 139.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 162.0, 163.0, 162.0, 163.0, 161.0, 161.0, 163.0, 163.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 118.0, 76.0, 75.0, 75.0, 76.0, 119.0, 75.0], "value": 83.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 121.0, 85.0, 86.0, 85.0, 129.0, 85.0, 84.0, 133.0], "value": 97.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 116.0, 117.0, 117.0, 117.0, 118.0, 116.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 64.0, 62.0, 61.0, 63.0, 62.0, 62.0, 62.0, 62.0, 62.0], "value": 63.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 65.0, 65.0, 67.0, 65.0, 70.0, 66.0, 66.0, 65.0], "value": 66.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 79.0, 79.0, 80.0, 78.0, 78.0, 82.0, 79.0, 80.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 131.0, 129.0, 132.0, 128.0, 130.0, 129.0, 132.0, 167.0, 130.0], "value": 134.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 166.0, 163.0, 171.0, 165.0, 165.0, 166.0, 168.0, 163.0, 162.0], "value": 165.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 77.0, 67.0, 70.0, 66.0, 65.0, 66.0, 65.0, 66.0], "value": 68.0, "unit": "score"}], "name": "kraken", "value": 1533.3000000000002, "alertThreshold": 2.0}]} 17:17:50 INFO - Return code: 0 17:17:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:17:51 INFO - # TBPL SUCCESS # 17:17:51 INFO - Running post-action listener: _resource_record_post_action 17:17:51 INFO - [mozharness: 2016-08-08 00:17:51.034200Z] Finished run-tests step (success) 17:17:51 INFO - Running post-run listener: _resource_record_post_run 17:17:51 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 524898304; Read time: 152; Write time: 373412 17:17:51 INFO - TinderboxPrint: CPU usage
13.0% 17:17:51 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 152 17:17:51 INFO - TinderboxPrint: I/O write bytes / time
524,898,304 / 373,412 17:17:51 INFO - TinderboxPrint: CPU idle
8,326.5 (87.0%) 17:17:51 INFO - TinderboxPrint: CPU user
1,200.8 (12.5%) 17:17:51 INFO - TinderboxPrint: Swap in / out
0 / 0 17:17:51 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 237932544; Read time: 152; Write time: 194068 17:17:51 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 286965760; Read time: 0; Write time: 179344 17:17:51 INFO - Running post-run listener: _upload_blobber_files 17:17:51 INFO - Blob upload gear active. 17:17:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:17:51 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:17:51 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'] 17:17:51 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 17:17:52 INFO - (blobuploader) - INFO - Open directory for files ... 17:17:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:17:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:17:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:17:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:17:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:17:56 INFO - (blobuploader) - INFO - Done attempting. 17:17:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:17:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:17:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:17:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:17:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:17:57 INFO - (blobuploader) - INFO - Done attempting. 17:17:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:17:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:17:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:17:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:17:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:17:58 INFO - (blobuploader) - INFO - Done attempting. 17:17:58 INFO - (blobuploader) - INFO - Iteration through files over. 17:17:58 INFO - Return code: 0 17:17:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:17:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:17:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/80da006565aed47a845a31e2859e19f90e55f6c7649d508641eceb7e08516a0c9718dc50f5ffe3874c456b3c54b86bfe659c02b79ddf7e58f49b5bbb689316be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4dd77b460d883fc86cc86efee655e827832dec3f952b9fb6b6e66bbd9fcc394d1d934d3ea1f1e971f640cc4d0527d23e6f7df051216a607dcbb24d8f479fa385", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/271436f1fe355e5d040ad4c71c206b2ec186a94273e071d99ea6a7efe0d42081e995c82e0558792ba681a60caf849d7fcf11c2b4044c3e8650a4aaaa879de7b2"} 17:17:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:17:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:17:58 INFO - Contents: 17:17:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/80da006565aed47a845a31e2859e19f90e55f6c7649d508641eceb7e08516a0c9718dc50f5ffe3874c456b3c54b86bfe659c02b79ddf7e58f49b5bbb689316be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4dd77b460d883fc86cc86efee655e827832dec3f952b9fb6b6e66bbd9fcc394d1d934d3ea1f1e971f640cc4d0527d23e6f7df051216a607dcbb24d8f479fa385", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/271436f1fe355e5d040ad4c71c206b2ec186a94273e071d99ea6a7efe0d42081e995c82e0558792ba681a60caf849d7fcf11c2b4044c3e8650a4aaaa879de7b2"} 17:17:58 INFO - Running post-run listener: copy_logs_to_upload_dir 17:17:58 INFO - Copying logs to upload dir... 17:17:58 INFO - mkdir: /builds/slave/test/build/upload/logs 17:17:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.395439 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-08-07 17:17:57.797120) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-07 17:17:57.800631) ========= 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=20e666a3d4cfbb71505a330e000001b4-1470614235.321695-453361860 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/80da006565aed47a845a31e2859e19f90e55f6c7649d508641eceb7e08516a0c9718dc50f5ffe3874c456b3c54b86bfe659c02b79ddf7e58f49b5bbb689316be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4dd77b460d883fc86cc86efee655e827832dec3f952b9fb6b6e66bbd9fcc394d1d934d3ea1f1e971f640cc4d0527d23e6f7df051216a607dcbb24d8f479fa385", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/271436f1fe355e5d040ad4c71c206b2ec186a94273e071d99ea6a7efe0d42081e995c82e0558792ba681a60caf849d7fcf11c2b4044c3e8650a4aaaa879de7b2"} build_url:https://queue.taskcluster.net/v1/task/K0pQ_17-StKRnMs7IK1ykg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011404 build_url: 'https://queue.taskcluster.net/v1/task/K0pQ_17-StKRnMs7IK1ykg/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/80da006565aed47a845a31e2859e19f90e55f6c7649d508641eceb7e08516a0c9718dc50f5ffe3874c456b3c54b86bfe659c02b79ddf7e58f49b5bbb689316be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4dd77b460d883fc86cc86efee655e827832dec3f952b9fb6b6e66bbd9fcc394d1d934d3ea1f1e971f640cc4d0527d23e6f7df051216a607dcbb24d8f479fa385", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/271436f1fe355e5d040ad4c71c206b2ec186a94273e071d99ea6a7efe0d42081e995c82e0558792ba681a60caf849d7fcf11c2b4044c3e8650a4aaaa879de7b2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-07 17:17:57.829843) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 17:17:57.830745) ========= 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=20e666a3d4cfbb71505a330e000001b4-1470614235.321695-453361860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004395 ========= master_lag: 0.20 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 17:17:58.036099) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-07 17:17:58.036472) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-07 17:17:58.036772) ========= ========= Total master_lag: 0.31 =========