builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-046 starttime: 1474485383.95 results: success (0) buildid: 20160921093047 builduid: 62011248b8fc41cc97644f502d2fe68f revision: c1e0b205c39b8946dfb485c0ecee7a5bc640815c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-21 12:16:23.947591) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-21 12:16:23.947979) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-21 12:16:23.948273) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-21 12:16:23.986272) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-21 12:16:23.986536) ========= 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=652eb03db935cfc1c15ebda0000001ad-1474483357.192167-1059196066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-21 12:16:24-- 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% 18.5M=0.001s 2016-09-21 12:16:24 (18.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.135357 ========= master_lag: 1.54 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-21 12:16:25.660912) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 12:16:25.661267) ========= 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=652eb03db935cfc1c15ebda0000001ad-1474483357.192167-1059196066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021737 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 12:16:25.707547) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-21 12:16:25.707894) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c1e0b205c39b8946dfb485c0ecee7a5bc640815c --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 c1e0b205c39b8946dfb485c0ecee7a5bc640815c --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=652eb03db935cfc1c15ebda0000001ad-1474483357.192167-1059196066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-21 12:16:26,030 truncating revision to first 12 chars 2016-09-21 12:16:26,030 Setting DEBUG logging. 2016-09-21 12:16:26,031 attempt 1/10 2016-09-21 12:16:26,031 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c1e0b205c39b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-21 12:16:27,275 unpacking tar archive at: fx-team-c1e0b205c39b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.583269 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-21 12:16:27.314874) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-21 12:16:27.315662) ========= script_repo_revision: c1e0b205c39b8946dfb485c0ecee7a5bc640815c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-21 12:16:27.316638) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-21 12:16:27.317357) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-21 12:16:27.329547) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-09-21 12:16:27.329859) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=652eb03db935cfc1c15ebda0000001ad-1474483357.192167-1059196066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:16:27 INFO - MultiFileLogger online at 20160921 12:16:27 in /builds/slave/test 12:16:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 12:16:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:16:27 INFO - {'append_to_log': False, 12:16:27 INFO - 'base_work_dir': '/builds/slave/test', 12:16:27 INFO - 'blob_upload_branch': 'Fx-Team', 12:16:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:16:27 INFO - 'branch': 'Fx-Team', 12:16:27 INFO - 'buildbot_json_path': 'buildprops.json', 12:16:27 INFO - 'config_files': ('talos/linux_config.py',), 12:16:27 INFO - 'default_actions': ('clobber', 12:16:27 INFO - 'read-buildbot-config', 12:16:27 INFO - 'download-and-extract', 12:16:27 INFO - 'populate-webroot', 12:16:27 INFO - 'create-virtualenv', 12:16:27 INFO - 'install', 12:16:27 INFO - 'run-tests'), 12:16:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:16:27 INFO - 'download_minidump_stackwalk': True, 12:16:27 INFO - 'download_symbols': 'ondemand', 12:16:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:16:27 INFO - 'tooltool.py': '/tools/tooltool.py', 12:16:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:16:27 INFO - '/tools/misc-python/virtualenv.py')}, 12:16:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:16:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:16:27 INFO - 'installer_path': 'installer.exe', 12:16:27 INFO - 'log_level': 'info', 12:16:27 INFO - 'log_name': 'talos', 12:16:27 INFO - 'log_to_console': True, 12:16:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:16:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:16:27 INFO - 'opt_config_files': (), 12:16:27 INFO - 'pip_index': False, 12:16:27 INFO - 'sps_profile': False, 12:16:27 INFO - 'sps_profile_interval': 0, 12:16:27 INFO - 'suite': 'dromaeojs', 12:16:27 INFO - 'system_bits': '32', 12:16:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:16:27 INFO - 'title': 'talos-linux64-ix-046', 12:16:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:16:27 INFO - 'use_talos_json': True, 12:16:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:16:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:16:27 INFO - 'work_dir': 'build'} 12:16:27 INFO - [mozharness: 2016-09-21 19:16:27.739722Z] Running clobber step. 12:16:27 INFO - Running pre-action listener: _resource_record_pre_action 12:16:27 INFO - Running main action method: clobber 12:16:27 INFO - rmtree: /builds/slave/test/build 12:16:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:16:28 INFO - Running post-action listener: _resource_record_post_action 12:16:28 INFO - [mozharness: 2016-09-21 19:16:28.716903Z] Finished clobber step (success) 12:16:28 INFO - [mozharness: 2016-09-21 19:16:28.717002Z] Running read-buildbot-config step. 12:16:28 INFO - Running pre-action listener: _resource_record_pre_action 12:16:28 INFO - Running main action method: read_buildbot_config 12:16:28 INFO - Using buildbot properties: 12:16:28 INFO - { 12:16:28 INFO - "project": "", 12:16:28 INFO - "product": "firefox", 12:16:28 INFO - "script_repo_revision": "production", 12:16:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:16:28 INFO - "repository": "", 12:16:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 12:16:28 INFO - "buildid": "20160921093047", 12:16:28 INFO - "pgo_build": "True", 12:16:28 INFO - "basedir": "/builds/slave/test", 12:16:28 INFO - "buildnumber": 463, 12:16:28 INFO - "slavename": "talos-linux64-ix-046", 12:16:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:16:28 INFO - "platform": "ubuntu64_hw", 12:16:28 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 12:16:28 INFO - "branch": "fx-team", 12:16:28 INFO - "repo_path": "integration/fx-team", 12:16:28 INFO - "revision": "c1e0b205c39b8946dfb485c0ecee7a5bc640815c", 12:16:28 INFO - "stage_platform": "linux64-pgo", 12:16:28 INFO - "builduid": "62011248b8fc41cc97644f502d2fe68f", 12:16:28 INFO - "slavebuilddir": "test" 12:16:28 INFO - } 12:16:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/N6LK0xR1TcSwN_K8AVA7IA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 12:16:28 INFO - Running post-action listener: _resource_record_post_action 12:16:28 INFO - [mozharness: 2016-09-21 19:16:28.719438Z] Finished read-buildbot-config step (success) 12:16:28 INFO - [mozharness: 2016-09-21 19:16:28.719528Z] Running download-and-extract step. 12:16:28 INFO - Running pre-action listener: _resource_record_pre_action 12:16:28 INFO - Running main action method: download_and_extract 12:16:28 INFO - mkdir: /builds/slave/test/build/tests 12:16:28 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')]} 12:16:28 INFO - trying https://queue.taskcluster.net/v1/task/N6LK0xR1TcSwN_K8AVA7IA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:16:28 INFO - Downloading https://queue.taskcluster.net/v1/task/N6LK0xR1TcSwN_K8AVA7IA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:16:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N6LK0xR1TcSwN_K8AVA7IA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:16:29 INFO - Downloaded 1361 bytes. 12:16:29 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:16:29 INFO - Using the following test package requirements: 12:16:29 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:16:29 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:29 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:16:29 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:29 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:16:29 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:29 INFO - u'jsshell-linux-x86_64.zip'], 12:16:29 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:29 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:16:29 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:16:29 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:29 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:16:29 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:29 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:16:29 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:29 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:16:29 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:29 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:16:29 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:16:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N6LK0xR1TcSwN_K8AVA7IA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:16:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N6LK0xR1TcSwN_K8AVA7IA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:16:29 INFO - Fetch https://queue.taskcluster.net/v1/task/N6LK0xR1TcSwN_K8AVA7IA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:16:30 INFO - Expected file size: 21941799 12:16:34 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:16:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N6LK0xR1TcSwN_K8AVA7IA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:16:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N6LK0xR1TcSwN_K8AVA7IA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:16:34 INFO - Fetch https://queue.taskcluster.net/v1/task/N6LK0xR1TcSwN_K8AVA7IA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:16:34 INFO - Expected file size: 21941799 12:16:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N6LK0xR1TcSwN_K8AVA7IA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 12:16:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N6LK0xR1TcSwN_K8AVA7IA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:16:39 INFO - Fetch https://queue.taskcluster.net/v1/task/N6LK0xR1TcSwN_K8AVA7IA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 12:16:40 INFO - Expected file size: 14414059 12:16: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')]} 12:16:40 INFO - trying https://queue.taskcluster.net/v1/task/N6LK0xR1TcSwN_K8AVA7IA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:16:40 INFO - Downloading https://queue.taskcluster.net/v1/task/N6LK0xR1TcSwN_K8AVA7IA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:16:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N6LK0xR1TcSwN_K8AVA7IA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:16:42 INFO - Downloaded 59565783 bytes. 12:16:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/N6LK0xR1TcSwN_K8AVA7IA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:16:42 INFO - mkdir: /builds/slave/test/properties 12:16:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:16:42 INFO - Writing to file /builds/slave/test/properties/build_url 12:16:42 INFO - Contents: 12:16:42 INFO - build_url:https://queue.taskcluster.net/v1/task/N6LK0xR1TcSwN_K8AVA7IA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:16:43 INFO - Running post-action listener: _resource_record_post_action 12:16:43 INFO - Running post-action listener: set_extra_try_arguments 12:16:43 INFO - [mozharness: 2016-09-21 19:16:43.380466Z] Finished download-and-extract step (success) 12:16:43 INFO - [mozharness: 2016-09-21 19:16:43.380736Z] Running populate-webroot step. 12:16:43 INFO - Running pre-action listener: _resource_record_pre_action 12:16:43 INFO - Running main action method: populate_webroot 12:16:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:16:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:16:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:16:43 INFO - '--tppagecycles', 12:16:43 INFO - '7'], 12:16:43 INFO - 'tests': ['tsvgm']}}, 12:16:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:16:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:16:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:16:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:16:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:16:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:16:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:43 INFO - 'talos_options': ['--disable-e10s'], 12:16:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:16:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:16:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:43 INFO - 'talos_options': ['--disable-e10s'], 12:16:43 INFO - 'tests': ['damp', 'tps']}, 12:16:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:43 INFO - 'tests': ['damp', 'tps']}, 12:16:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:16:43 INFO - 'tests': ['dromaeo_dom']}, 12:16:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:16:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:16:43 INFO - 'tests': ['basic_compositor_video']}, 12:16:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:16:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:16:43 INFO - 'tests': ['a11yr', 12:16:43 INFO - 'ts_paint', 12:16:43 INFO - 'tpaint', 12:16:43 INFO - 'sessionrestore', 12:16:43 INFO - 'sessionrestore_no_auto_restore', 12:16:43 INFO - 'tabpaint']}, 12:16:43 INFO - 'other-e10s': {'tests': ['a11yr', 12:16:43 INFO - 'ts_paint', 12:16:43 INFO - 'tpaint', 12:16:43 INFO - 'sessionrestore', 12:16:43 INFO - 'sessionrestore_no_auto_restore', 12:16:43 INFO - 'tabpaint']}, 12:16:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:16:43 INFO - 'ts_paint', 12:16:43 INFO - 'tpaint', 12:16:43 INFO - 'sessionrestore', 12:16:43 INFO - 'sessionrestore_no_auto_restore', 12:16:43 INFO - 'tabpaint']}, 12:16:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:16:43 INFO - 'ts_paint', 12:16:43 INFO - 'tpaint', 12:16:43 INFO - 'sessionrestore', 12:16:43 INFO - 'sessionrestore_no_auto_restore', 12:16:43 INFO - 'tabpaint']}, 12:16:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:16:43 INFO - 'tests': ['a11yr', 12:16:43 INFO - 'ts_paint', 12:16:43 INFO - 'tpaint', 12:16:43 INFO - 'sessionrestore', 12:16:43 INFO - 'sessionrestore_no_auto_restore', 12:16:43 INFO - 'tabpaint']}, 12:16:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:16:43 INFO - 'tests': ['a11yr', 12:16:43 INFO - 'ts_paint', 12:16:43 INFO - 'tpaint', 12:16:43 INFO - 'sessionrestore', 12:16:43 INFO - 'sessionrestore_no_auto_restore', 12:16:43 INFO - 'tabpaint']}, 12:16:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:16:43 INFO - 'tests': ['tsvgx', 12:16:43 INFO - 'tsvgr_opacity', 12:16:43 INFO - 'tart', 12:16:43 INFO - 'tscrollx', 12:16:43 INFO - 'cart']}, 12:16:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:16:43 INFO - 'tsvgr_opacity', 12:16:43 INFO - 'tart', 12:16:43 INFO - 'tscrollx', 12:16:43 INFO - 'cart']}, 12:16:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:43 INFO - 'talos_options': ['--disable-e10s'], 12:16:43 INFO - 'tests': ['tp5o']}, 12:16:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:43 INFO - 'tests': ['tp5o']}, 12:16:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:43 INFO - 'talos_options': ['--disable-e10s', 12:16:43 INFO - '--xperf_path', 12:16:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:16:43 INFO - 'tests': ['tp5n']}, 12:16:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:43 INFO - 'talos_options': ['--xperf_path', 12:16:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:16:43 INFO - 'tests': ['tp5n']}}, 12:16:43 INFO - 'talos.zip': {'path': '', 12:16:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:16:43 INFO - Running post-action listener: _resource_record_post_action 12:16:43 INFO - [mozharness: 2016-09-21 19:16:43.396694Z] Finished populate-webroot step (success) 12:16:43 INFO - [mozharness: 2016-09-21 19:16:43.396784Z] Running create-virtualenv step. 12:16:43 INFO - Running pre-action listener: _resource_record_pre_action 12:16:43 INFO - Running main action method: create_virtualenv 12:16:43 INFO - Creating virtualenv /builds/slave/test/build/venv 12:16:43 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 12:16:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:16:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:16:43 INFO - Using real prefix '/usr' 12:16:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:16:43 INFO - Installing distribute.............................................................................................................................................................................................done. 12:16:45 INFO - Installing pip.................done. 12:16:45 INFO - Return code: 0 12:16:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:16:45 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')]} 12:16:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:45 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')]} 12:16:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:45 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 0x7f5f180c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ea790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e7930>, '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 0x23e8830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e8cc0>, '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': '652eb03db935cfc1c15ebda0000001ad-1474483357.192167-1059196066', '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 12:16:45 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 12:16:45 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 12:16:45 INFO - Using env: {'DISPLAY': ':0', 12:16:45 INFO - 'HOME': '/home/cltbld', 12:16:45 INFO - 'LANG': 'en_US.UTF-8', 12:16:45 INFO - 'LANGUAGE': 'en_US:en', 12:16:45 INFO - 'LOGNAME': 'cltbld', 12:16:45 INFO - 'MAIL': '/var/mail/cltbld', 12:16:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:45 INFO - 'MOZ_NO_REMOTE': '1', 12:16:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:45 INFO - 'NO_EM_RESTART': '1', 12:16:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:45 INFO - 'PWD': '/builds/slave/test', 12:16:45 INFO - 'SHELL': '/bin/bash', 12:16:45 INFO - 'SHLVL': '1', 12:16:45 INFO - 'TERM': 'linux', 12:16:45 INFO - 'TMOUT': '86400', 12:16:45 INFO - 'USER': 'cltbld', 12:16:45 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1474483357.192167-1059196066', 12:16:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:45 INFO - '_': '/tools/buildbot/bin/python'} 12:16:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:46 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 12:16:46 INFO - Cleaning up... 12:16:46 INFO - Return code: 0 12:16:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:16: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')]} 12:16:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16: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')]} 12:16:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:46 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 0x7f5f180c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ea790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e7930>, '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 0x23e8830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e8cc0>, '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': '652eb03db935cfc1c15ebda0000001ad-1474483357.192167-1059196066', '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 12:16:46 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 12:16:46 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 12:16:46 INFO - Using env: {'DISPLAY': ':0', 12:16:46 INFO - 'HOME': '/home/cltbld', 12:16:46 INFO - 'LANG': 'en_US.UTF-8', 12:16:46 INFO - 'LANGUAGE': 'en_US:en', 12:16:46 INFO - 'LOGNAME': 'cltbld', 12:16:46 INFO - 'MAIL': '/var/mail/cltbld', 12:16:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:46 INFO - 'MOZ_NO_REMOTE': '1', 12:16:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:46 INFO - 'NO_EM_RESTART': '1', 12:16:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:46 INFO - 'PWD': '/builds/slave/test', 12:16:46 INFO - 'SHELL': '/bin/bash', 12:16:46 INFO - 'SHLVL': '1', 12:16:46 INFO - 'TERM': 'linux', 12:16:46 INFO - 'TMOUT': '86400', 12:16:46 INFO - 'USER': 'cltbld', 12:16:46 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1474483357.192167-1059196066', 12:16:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:46 INFO - '_': '/tools/buildbot/bin/python'} 12:16:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:46 INFO - Downloading/unpacking psutil>=3.1.1 12:16:46 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 12:16:46 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 12:16:46 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 12:16:46 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 12:16:46 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 12:16:46 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 12:16:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:16:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:16:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:16:48 INFO - Installing collected packages: psutil 12:16:48 INFO - Running setup.py install for psutil 12:16:48 INFO - building 'psutil._psutil_linux' extension 12:16:48 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 12:16:48 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 12:16:48 INFO - building 'psutil._psutil_posix' extension 12:16:48 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 12:16:48 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 12:16:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:16:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:16:48 INFO - Successfully installed psutil 12:16:48 INFO - Cleaning up... 12:16:48 INFO - Return code: 0 12:16:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:16:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:16:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:48 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 0x7f5f180c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ea790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e7930>, '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 0x23e8830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e8cc0>, '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': '652eb03db935cfc1c15ebda0000001ad-1474483357.192167-1059196066', '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 12:16:48 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 12:16:48 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 12:16:48 INFO - Using env: {'DISPLAY': ':0', 12:16:48 INFO - 'HOME': '/home/cltbld', 12:16:48 INFO - 'LANG': 'en_US.UTF-8', 12:16:48 INFO - 'LANGUAGE': 'en_US:en', 12:16:48 INFO - 'LOGNAME': 'cltbld', 12:16:48 INFO - 'MAIL': '/var/mail/cltbld', 12:16:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:48 INFO - 'MOZ_NO_REMOTE': '1', 12:16:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:48 INFO - 'NO_EM_RESTART': '1', 12:16:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:48 INFO - 'PWD': '/builds/slave/test', 12:16:48 INFO - 'SHELL': '/bin/bash', 12:16:48 INFO - 'SHLVL': '1', 12:16:48 INFO - 'TERM': 'linux', 12:16:48 INFO - 'TMOUT': '86400', 12:16:48 INFO - 'USER': 'cltbld', 12:16:48 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1474483357.192167-1059196066', 12:16:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:48 INFO - '_': '/tools/buildbot/bin/python'} 12:16:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:16:49 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 12:16:49 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 12:16:49 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 12:16:49 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 12:16:49 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 12:16:49 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 12:16:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:16:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:16:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:16:52 INFO - Installing collected packages: mozsystemmonitor 12:16:52 INFO - Running setup.py install for mozsystemmonitor 12:16:52 INFO - Successfully installed mozsystemmonitor 12:16:52 INFO - Cleaning up... 12:16:52 INFO - Return code: 0 12:16:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:16:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:16:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:52 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 0x7f5f180c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ea790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e7930>, '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 0x23e8830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e8cc0>, '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': '652eb03db935cfc1c15ebda0000001ad-1474483357.192167-1059196066', '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 12:16:52 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 12:16:52 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 12:16:52 INFO - Using env: {'DISPLAY': ':0', 12:16:52 INFO - 'HOME': '/home/cltbld', 12:16:52 INFO - 'LANG': 'en_US.UTF-8', 12:16:52 INFO - 'LANGUAGE': 'en_US:en', 12:16:52 INFO - 'LOGNAME': 'cltbld', 12:16:52 INFO - 'MAIL': '/var/mail/cltbld', 12:16:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:52 INFO - 'MOZ_NO_REMOTE': '1', 12:16:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:52 INFO - 'NO_EM_RESTART': '1', 12:16:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:52 INFO - 'PWD': '/builds/slave/test', 12:16:52 INFO - 'SHELL': '/bin/bash', 12:16:52 INFO - 'SHLVL': '1', 12:16:52 INFO - 'TERM': 'linux', 12:16:52 INFO - 'TMOUT': '86400', 12:16:52 INFO - 'USER': 'cltbld', 12:16:52 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1474483357.192167-1059196066', 12:16:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:52 INFO - '_': '/tools/buildbot/bin/python'} 12:16:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:52 INFO - Downloading/unpacking jsonschema==2.5.1 12:16:52 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 12:16:52 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 12:16:52 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 12:16:52 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 12:16:52 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 12:16:52 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 12:16:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:16:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:16:54 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 12:16:54 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 12:16:54 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 12:16:54 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 12:16:54 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 12:16:54 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 12:16:54 INFO - Downloading functools32-3.2.3-2.tar.gz 12:16:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:16:54 INFO - warning: no files found matching '*.txt' 12:16:54 INFO - no previously-included directories found matching 'build' 12:16:54 INFO - no previously-included directories found matching 'dist' 12:16:54 INFO - no previously-included directories found matching '.git*' 12:16:54 INFO - Installing collected packages: jsonschema, functools32 12:16:54 INFO - Running setup.py install for functools32 12:16:55 INFO - warning: no files found matching '*.txt' 12:16:55 INFO - no previously-included directories found matching 'build' 12:16:55 INFO - no previously-included directories found matching 'dist' 12:16:55 INFO - no previously-included directories found matching '.git*' 12:16:55 INFO - Successfully installed jsonschema functools32 12:16:55 INFO - Cleaning up... 12:16:55 INFO - Return code: 0 12:16:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:16:55 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')]} 12:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:55 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')]} 12:16:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:55 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 0x7f5f180c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ea790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e7930>, '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 0x23e8830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e8cc0>, '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': '652eb03db935cfc1c15ebda0000001ad-1474483357.192167-1059196066', '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 12:16:55 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 12:16:55 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 12:16:55 INFO - Using env: {'DISPLAY': ':0', 12:16:55 INFO - 'HOME': '/home/cltbld', 12:16:55 INFO - 'LANG': 'en_US.UTF-8', 12:16:55 INFO - 'LANGUAGE': 'en_US:en', 12:16:55 INFO - 'LOGNAME': 'cltbld', 12:16:55 INFO - 'MAIL': '/var/mail/cltbld', 12:16:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:55 INFO - 'MOZ_NO_REMOTE': '1', 12:16:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:55 INFO - 'NO_EM_RESTART': '1', 12:16:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:55 INFO - 'PWD': '/builds/slave/test', 12:16:55 INFO - 'SHELL': '/bin/bash', 12:16:55 INFO - 'SHLVL': '1', 12:16:55 INFO - 'TERM': 'linux', 12:16:55 INFO - 'TMOUT': '86400', 12:16:55 INFO - 'USER': 'cltbld', 12:16:55 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1474483357.192167-1059196066', 12:16:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:55 INFO - '_': '/tools/buildbot/bin/python'} 12:16:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:16:55 INFO - Cleaning up... 12:16:55 INFO - Return code: 0 12:16:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:16:55 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')]} 12:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:55 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')]} 12:16:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:55 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 0x7f5f180c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ea790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e7930>, '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 0x23e8830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e8cc0>, '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': '652eb03db935cfc1c15ebda0000001ad-1474483357.192167-1059196066', '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 12:16:55 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 12:16:55 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 12:16:55 INFO - Using env: {'DISPLAY': ':0', 12:16:55 INFO - 'HOME': '/home/cltbld', 12:16:55 INFO - 'LANG': 'en_US.UTF-8', 12:16:55 INFO - 'LANGUAGE': 'en_US:en', 12:16:55 INFO - 'LOGNAME': 'cltbld', 12:16:55 INFO - 'MAIL': '/var/mail/cltbld', 12:16:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:55 INFO - 'MOZ_NO_REMOTE': '1', 12:16:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:55 INFO - 'NO_EM_RESTART': '1', 12:16:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:55 INFO - 'PWD': '/builds/slave/test', 12:16:55 INFO - 'SHELL': '/bin/bash', 12:16:55 INFO - 'SHLVL': '1', 12:16:55 INFO - 'TERM': 'linux', 12:16:55 INFO - 'TMOUT': '86400', 12:16:55 INFO - 'USER': 'cltbld', 12:16:55 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1474483357.192167-1059196066', 12:16:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:55 INFO - '_': '/tools/buildbot/bin/python'} 12:16:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:55 INFO - Downloading/unpacking blobuploader==1.2.4 12:16:55 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 12:16:55 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 12:16:55 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 12:16:55 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 12:16:55 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 12:16:55 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 12:16:57 INFO - Downloading blobuploader-1.2.4.tar.gz 12:16:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:16:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:16:57 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 12:16:57 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 12:16:57 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 12:16:57 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 12:16:57 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 12:16:57 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 12:16:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:16:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:16:57 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 12:16:57 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 12:16:57 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 12:16:57 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 12:16:57 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 12:16:57 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 12:16:58 INFO - Downloading docopt-0.6.1.tar.gz 12:16:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:16:58 INFO - Installing collected packages: blobuploader, requests, docopt 12:16:58 INFO - Running setup.py install for blobuploader 12:16:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:16:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:16:58 INFO - Running setup.py install for requests 12:16:58 INFO - Running setup.py install for docopt 12:16:58 INFO - Successfully installed blobuploader requests docopt 12:16:58 INFO - Cleaning up... 12:16:58 INFO - Return code: 0 12:16:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:16:58 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')]} 12:16:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:58 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')]} 12:16:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:58 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 0x7f5f180c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ea790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e7930>, '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 0x23e8830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e8cc0>, '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': '652eb03db935cfc1c15ebda0000001ad-1474483357.192167-1059196066', '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 12:16:58 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 12:16:58 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 12:16:58 INFO - Using env: {'DISPLAY': ':0', 12:16:58 INFO - 'HOME': '/home/cltbld', 12:16:58 INFO - 'LANG': 'en_US.UTF-8', 12:16:58 INFO - 'LANGUAGE': 'en_US:en', 12:16:58 INFO - 'LOGNAME': 'cltbld', 12:16:58 INFO - 'MAIL': '/var/mail/cltbld', 12:16:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:58 INFO - 'MOZ_NO_REMOTE': '1', 12:16:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:58 INFO - 'NO_EM_RESTART': '1', 12:16:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:58 INFO - 'PWD': '/builds/slave/test', 12:16:58 INFO - 'SHELL': '/bin/bash', 12:16:58 INFO - 'SHLVL': '1', 12:16:58 INFO - 'TERM': 'linux', 12:16:58 INFO - 'TMOUT': '86400', 12:16:58 INFO - 'USER': 'cltbld', 12:16:58 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1474483357.192167-1059196066', 12:16:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:58 INFO - '_': '/tools/buildbot/bin/python'} 12:16:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:16:59 INFO - Running setup.py (path:/tmp/pip-LmaHFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:16:59 INFO - Running setup.py (path:/tmp/pip-9F7337-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:16:59 INFO - Running setup.py (path:/tmp/pip-8Moa0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:16:59 INFO - Running setup.py (path:/tmp/pip-IRtn71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:16:59 INFO - Running setup.py (path:/tmp/pip-_fB468-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:16:59 INFO - Running setup.py (path:/tmp/pip-iH3BO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:16:59 INFO - Running setup.py (path:/tmp/pip-cy2x7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:16:59 INFO - Running setup.py (path:/tmp/pip-SYnb4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:16:59 INFO - Running setup.py (path:/tmp/pip-wbH9Qo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:16:59 INFO - Running setup.py (path:/tmp/pip-7amkv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:16:59 INFO - Running setup.py (path:/tmp/pip-RfQwpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:16:59 INFO - Running setup.py (path:/tmp/pip-IWZS7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:16:59 INFO - Running setup.py (path:/tmp/pip-nlku3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:16:59 INFO - Running setup.py (path:/tmp/pip-X2Qb03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:00 INFO - Running setup.py (path:/tmp/pip-i8bqd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:17:00 INFO - Running setup.py (path:/tmp/pip-Z9Fcla-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:17:00 INFO - Running setup.py (path:/tmp/pip-phvmhz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:17:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:17:00 INFO - Running setup.py install for manifestparser 12:17:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:17:00 INFO - Running setup.py install for mozcrash 12:17:00 INFO - Running setup.py install for mozdebug 12:17:00 INFO - Running setup.py install for mozdevice 12:17:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:17:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:17:00 INFO - Running setup.py install for mozfile 12:17:00 INFO - Running setup.py install for mozhttpd 12:17:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:17:00 INFO - Running setup.py install for mozinfo 12:17:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:17:00 INFO - Running setup.py install for mozInstall 12:17:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:17:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:17:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:17:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:17:01 INFO - Running setup.py install for mozleak 12:17:01 INFO - Running setup.py install for mozlog 12:17:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:17:01 INFO - Running setup.py install for moznetwork 12:17:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:17:01 INFO - Running setup.py install for mozprocess 12:17:01 INFO - Running setup.py install for mozprofile 12:17:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:17:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:17:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:17:01 INFO - Running setup.py install for mozrunner 12:17:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:17:01 INFO - Running setup.py install for mozscreenshot 12:17:01 INFO - Running setup.py install for moztest 12:17:01 INFO - Running setup.py install for mozversion 12:17:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:17:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:17:02 INFO - Cleaning up... 12:17:02 INFO - Return code: 0 12:17:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:17:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:17:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:02 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 0x7f5f180c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ea790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e7930>, '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 0x23e8830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e8cc0>, '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': '652eb03db935cfc1c15ebda0000001ad-1474483357.192167-1059196066', '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 12:17:02 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 12:17:02 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 12:17:02 INFO - Using env: {'DISPLAY': ':0', 12:17:02 INFO - 'HOME': '/home/cltbld', 12:17:02 INFO - 'LANG': 'en_US.UTF-8', 12:17:02 INFO - 'LANGUAGE': 'en_US:en', 12:17:02 INFO - 'LOGNAME': 'cltbld', 12:17:02 INFO - 'MAIL': '/var/mail/cltbld', 12:17:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:02 INFO - 'MOZ_NO_REMOTE': '1', 12:17:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:02 INFO - 'NO_EM_RESTART': '1', 12:17:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:02 INFO - 'PWD': '/builds/slave/test', 12:17:02 INFO - 'SHELL': '/bin/bash', 12:17:02 INFO - 'SHLVL': '1', 12:17:02 INFO - 'TERM': 'linux', 12:17:02 INFO - 'TMOUT': '86400', 12:17:02 INFO - 'USER': 'cltbld', 12:17:02 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1474483357.192167-1059196066', 12:17:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:02 INFO - '_': '/tools/buildbot/bin/python'} 12:17:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:17:02 INFO - Running setup.py (path:/tmp/pip-idzd_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:17:02 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)) 12:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:17:02 INFO - Running setup.py (path:/tmp/pip-bskVye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:17:02 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)) 12:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:17:02 INFO - Running setup.py (path:/tmp/pip-JnmaZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:17:02 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)) 12:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:17:02 INFO - Running setup.py (path:/tmp/pip-zwHbdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:17:02 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)) 12:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:17:02 INFO - Running setup.py (path:/tmp/pip-iuAeHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:17:02 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)) 12:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:17:02 INFO - Running setup.py (path:/tmp/pip-ndsk4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:17:02 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)) 12:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:17:02 INFO - Running setup.py (path:/tmp/pip-eW78C6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:17:02 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)) 12:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:17:02 INFO - Running setup.py (path:/tmp/pip-jhRmwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:17:02 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)) 12:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:17:02 INFO - Running setup.py (path:/tmp/pip-Ql_EVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:17:02 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)) 12:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:17:02 INFO - Running setup.py (path:/tmp/pip-ZctEu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:17:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 12:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:17:03 INFO - Running setup.py (path:/tmp/pip-Ov_3BL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:17:03 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)) 12:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:17:03 INFO - Running setup.py (path:/tmp/pip-ptK1OI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:17:03 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)) 12:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:17:03 INFO - Running setup.py (path:/tmp/pip-r5x4GN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:17:03 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)) 12:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:17:03 INFO - Running setup.py (path:/tmp/pip-FX8ilj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:17:03 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)) 12:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:03 INFO - Running setup.py (path:/tmp/pip-yqbFKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:03 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)) 12:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:17:03 INFO - Running setup.py (path:/tmp/pip-FWseVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:17:03 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)) 12:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:17:03 INFO - Running setup.py (path:/tmp/pip-45mRgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:17:03 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)) 12:17:03 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)) 12:17:03 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)) 12:17:03 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)) 12:17:03 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)) 12:17:03 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)) 12:17:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:05 INFO - Downloading blessings-1.6.tar.gz 12:17:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:17:05 INFO - Installing collected packages: blessings 12:17:05 INFO - Running setup.py install for blessings 12:17:05 INFO - Successfully installed blessings 12:17:05 INFO - Cleaning up... 12:17:05 INFO - Return code: 0 12:17:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:17:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:17:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:17:05 INFO - Reading from file tmpfile_stdout 12:17:05 INFO - Current package versions: 12:17:05 INFO - argparse == 1.2.1 12:17:05 INFO - blessings == 1.6 12:17:05 INFO - blobuploader == 1.2.4 12:17:05 INFO - docopt == 0.6.1 12:17:05 INFO - functools32 == 3.2.3-2 12:17:05 INFO - jsonschema == 2.5.1 12:17:05 INFO - manifestparser == 1.1 12:17:05 INFO - mozInstall == 1.12 12:17:05 INFO - mozcrash == 0.17 12:17:05 INFO - mozdebug == 0.1 12:17:05 INFO - mozdevice == 0.48 12:17:05 INFO - mozfile == 1.2 12:17:05 INFO - mozhttpd == 0.7 12:17:05 INFO - mozinfo == 0.9 12:17:05 INFO - mozleak == 0.1 12:17:05 INFO - mozlog == 3.4 12:17:05 INFO - moznetwork == 0.27 12:17:05 INFO - mozprocess == 0.23 12:17:05 INFO - mozprofile == 0.28 12:17:05 INFO - mozrunner == 6.12 12:17:05 INFO - mozscreenshot == 0.1 12:17:05 INFO - mozsystemmonitor == 0.3 12:17:05 INFO - moztest == 0.7 12:17:05 INFO - mozversion == 1.4 12:17:05 INFO - psutil == 3.1.1 12:17:05 INFO - requests == 1.2.3 12:17:05 INFO - wsgiref == 0.1.2 12:17:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:17:05 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')]} 12:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:05 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')]} 12:17:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:05 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 0x7f5f180c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ea790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e7930>, '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 0x23e8830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e8cc0>, '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': '652eb03db935cfc1c15ebda0000001ad-1474483357.192167-1059196066', '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 12:17:05 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 12:17:05 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 12:17:05 INFO - Using env: {'DISPLAY': ':0', 12:17:05 INFO - 'HOME': '/home/cltbld', 12:17:05 INFO - 'LANG': 'en_US.UTF-8', 12:17:05 INFO - 'LANGUAGE': 'en_US:en', 12:17:05 INFO - 'LOGNAME': 'cltbld', 12:17:05 INFO - 'MAIL': '/var/mail/cltbld', 12:17:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:05 INFO - 'MOZ_NO_REMOTE': '1', 12:17:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:05 INFO - 'NO_EM_RESTART': '1', 12:17:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:05 INFO - 'PWD': '/builds/slave/test', 12:17:05 INFO - 'SHELL': '/bin/bash', 12:17:05 INFO - 'SHLVL': '1', 12:17:05 INFO - 'TERM': 'linux', 12:17:05 INFO - 'TMOUT': '86400', 12:17:05 INFO - 'USER': 'cltbld', 12:17:05 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1474483357.192167-1059196066', 12:17:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:05 INFO - '_': '/tools/buildbot/bin/python'} 12:17:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:06 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)) 12:17:06 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)) 12:17:06 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)) 12:17:06 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)) 12:17:06 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)) 12:17:06 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)) 12:17:06 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)) 12:17:06 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)) 12:17:06 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)) 12:17:06 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)) 12:17:06 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)) 12:17:06 INFO - Cleaning up... 12:17:06 INFO - Return code: 0 12:17:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:17:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:17:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5f180c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ea790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e7930>, '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 0x23e8830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e8cc0>, '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': '652eb03db935cfc1c15ebda0000001ad-1474483357.192167-1059196066', '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 12:17:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:17:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:17:06 INFO - Using env: {'DISPLAY': ':0', 12:17:06 INFO - 'HOME': '/home/cltbld', 12:17:06 INFO - 'LANG': 'en_US.UTF-8', 12:17:06 INFO - 'LANGUAGE': 'en_US:en', 12:17:06 INFO - 'LOGNAME': 'cltbld', 12:17:06 INFO - 'MAIL': '/var/mail/cltbld', 12:17:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:06 INFO - 'MOZ_NO_REMOTE': '1', 12:17:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:06 INFO - 'NO_EM_RESTART': '1', 12:17:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:06 INFO - 'PWD': '/builds/slave/test', 12:17:06 INFO - 'SHELL': '/bin/bash', 12:17:06 INFO - 'SHLVL': '1', 12:17:06 INFO - 'TERM': 'linux', 12:17:06 INFO - 'TMOUT': '86400', 12:17:06 INFO - 'USER': 'cltbld', 12:17:06 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1474483357.192167-1059196066', 12:17:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:06 INFO - '_': '/tools/buildbot/bin/python'} 12:17:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:17:06 INFO - Cleaning up... 12:17:06 INFO - Return code: 0 12:17:06 INFO - Running post-action listener: _resource_record_post_action 12:17:06 INFO - Running post-action listener: _start_resource_monitoring 12:17:06 INFO - Starting resource monitoring. 12:17:06 INFO - [mozharness: 2016-09-21 19:17:06.392737Z] Finished create-virtualenv step (success) 12:17:06 INFO - [mozharness: 2016-09-21 19:17:06.393201Z] Running install step. 12:17:06 INFO - Running pre-action listener: _resource_record_pre_action 12:17:06 INFO - Running main action method: install 12:17:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:17:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:17:06 INFO - Reading from file tmpfile_stdout 12:17:06 INFO - Detecting whether we're running mozinstall >=1.0... 12:17:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:17:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:17:06 INFO - Reading from file tmpfile_stdout 12:17:06 INFO - Output received: 12:17:06 INFO - Usage: mozinstall [options] installer 12:17:06 INFO - Options: 12:17:06 INFO - -h, --help show this help message and exit 12:17:06 INFO - -d DEST, --destination=DEST 12:17:06 INFO - Directory to install application into. [default: 12:17:06 INFO - "/builds/slave/test"] 12:17:06 INFO - --app=APP Application being installed. [default: firefox] 12:17:06 INFO - mkdir: /builds/slave/test/build/application 12:17:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:17:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:17:23 INFO - Reading from file tmpfile_stdout 12:17:23 INFO - Output received: 12:17:23 INFO - /builds/slave/test/build/application/firefox/firefox 12:17:23 INFO - Running post-action listener: _resource_record_post_action 12:17:23 INFO - [mozharness: 2016-09-21 19:17:23.654179Z] Finished install step (success) 12:17:23 INFO - [mozharness: 2016-09-21 19:17:23.654423Z] Running run-tests step. 12:17:23 INFO - Running pre-action listener: _resource_record_pre_action 12:17:23 INFO - Running main action method: run_tests 12:17:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:17:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:17:23 INFO - Python 2.7.3 12:17:23 INFO - Return code: 0 12:17:23 INFO - grabbing minidump binary from tooltool 12:17:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:17:23 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 0x23e7930>, '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 0x23e8830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e8cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:17:23 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 12:17:23 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 12:17:23 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 12:17:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:17:23 INFO - Return code: 0 12:17:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:17:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:17:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:17:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:17:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:17:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N6LK0xR1TcSwN_K8AVA7IA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 12:17:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/N6LK0xR1TcSwN_K8AVA7IA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 12:17:23 INFO - Using env: {'DISPLAY': ':0', 12:17:23 INFO - 'HOME': '/home/cltbld', 12:17:23 INFO - 'LANG': 'en_US.UTF-8', 12:17:23 INFO - 'LANGUAGE': 'en_US:en', 12:17:23 INFO - 'LOGNAME': 'cltbld', 12:17:23 INFO - 'MAIL': '/var/mail/cltbld', 12:17:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:17:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:17:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:23 INFO - 'MOZ_NO_REMOTE': '1', 12:17:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:17:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:23 INFO - 'NO_EM_RESTART': '1', 12:17:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:23 INFO - 'PWD': '/builds/slave/test', 12:17:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:17:23 INFO - 'SHELL': '/bin/bash', 12:17:23 INFO - 'SHLVL': '1', 12:17:23 INFO - 'TERM': 'linux', 12:17:23 INFO - 'TMOUT': '86400', 12:17:23 INFO - 'USER': 'cltbld', 12:17:23 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1474483357.192167-1059196066', 12:17:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:23 INFO - '_': '/tools/buildbot/bin/python'} 12:17:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N6LK0xR1TcSwN_K8AVA7IA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 12:17:23 INFO - mozversion application_buildid: 20160921093047 12:17:23 INFO - mozversion application_changeset: c1e0b205c39b8946dfb485c0ecee7a5bc640815c 12:17:23 INFO - mozversion application_display_name: Nightly 12:17:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:17:23 INFO - mozversion application_name: Firefox 12:17:23 INFO - mozversion application_remotingname: firefox 12:17:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:17:23 INFO - mozversion application_vendor: Mozilla 12:17:23 INFO - mozversion application_version: 52.0a1 12:17:23 INFO - mozversion platform_buildid: 20160921093047 12:17:23 INFO - mozversion platform_changeset: c1e0b205c39b8946dfb485c0ecee7a5bc640815c 12:17:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:17:23 INFO - mozversion platform_version: 52.0a1 12:17:23 INFO - using testdate: 1474485443 12:17:23 INFO - actual date: 1474485443 12:17:23 INFO - starting webserver on 'localhost:43185' 12:17:23 INFO - SUITE-START | Running 2 tests 12:17:23 INFO - TEST-START | dromaeo_css 12:17:23 INFO - operating with platform_type : linux_ 12:17:23 INFO - Initialising browser for dromaeo_css test... 12:17:23 INFO - TEST-INFO | started process 23379 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWFWyMV/profile http://localhost:43185/getInfo.html) 12:17:28 INFO - PROCESS | 23379 | __metrics Screen width/height:1600/1200 12:17:28 INFO - PROCESS | 23379 | colorDepth:24 12:17:28 INFO - PROCESS | 23379 | Browser inner width/height: 1024/697 12:17:28 INFO - PROCESS | 23379 | __metrics 12:17:28 INFO - PROCESS | 23379 | 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" 12:17:28 INFO - PROCESS | 23379 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:17:29 INFO - PROCESS | 23379 | console.error: PushService: 12:17:29 INFO - PROCESS | 23379 | stateChangeProcessEnqueue: Error transitioning state 12:17:29 INFO - PROCESS | 23379 | UnknownError 12:17:30 INFO - TEST-INFO | 23379: exit 0 12:17:30 INFO - Browser initialized. 12:17:30 INFO - Running cycle 1/1 for dromaeo_css test... 12:17:30 INFO - TEST-INFO | started process 23458 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWFWyMV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:17:42 INFO - PROCESS | 23458 | RSS: Main: 173473792 12:17:42 INFO - PROCESS | 23458 | 12:18:33 INFO - PROCESS | 23458 | 1474485513349 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] 12:20:43 INFO - PROCESS | 23458 | Cycle 1(1): loaded http://localhost:43185/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43185/tests/dromaeo/cssquery-ext.html) 12:20:44 INFO - PROCESS | 23458 | RSS: Main: 307068928 12:20:44 INFO - PROCESS | 23458 | 12:23:46 INFO - PROCESS | 23458 | Cycle 1(1): loaded http://localhost:43185/tests/dromaeo/cssquery-ext.html (next: http://localhost:43185/tests/dromaeo/cssquery-jquery.html) 12:23:47 INFO - PROCESS | 23458 | RSS: Main: 270745600 12:23:47 INFO - PROCESS | 23458 | 12:26:49 INFO - PROCESS | 23458 | Cycle 1(1): loaded http://localhost:43185/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43185/tests/dromaeo/cssquery-mootools.html) 12:26:49 INFO - PROCESS | 23458 | RSS: Main: 243769344 12:26:49 INFO - PROCESS | 23458 | 12:29:51 INFO - PROCESS | 23458 | Cycle 1(1): loaded http://localhost:43185/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43185/tests/dromaeo/cssquery-prototype.html) 12:29:52 INFO - PROCESS | 23458 | RSS: Main: 216985600 12:29:52 INFO - PROCESS | 23458 | 12:32:55 INFO - PROCESS | 23458 | Cycle 1(1): loaded http://localhost:43185/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43185/tests/dromaeo/cssquery-yui.html) 12:32:55 INFO - PROCESS | 23458 | RSS: Main: 216567808 12:32:55 INFO - PROCESS | 23458 | 12:35:58 INFO - PROCESS | 23458 | Cycle 1(1): loaded http://localhost:43185/tests/dromaeo/cssquery-yui.html (next: http://localhost:43185/tests/dromaeo/cssquery-dojo.html) 12:35:58 INFO - PROCESS | 23458 | RSS: Main: 309010432 12:35:58 INFO - PROCESS | 23458 | 12:35:58 INFO - PROCESS | 23458 | __start_tp_report 12:35:58 INFO - PROCESS | 23458 | _x_x_mozilla_page_load 12:35:58 INFO - PROCESS | 23458 | _x_x_mozilla_page_load_details 12:35:58 INFO - PROCESS | 23458 | |i|pagename|runs| 12:35:58 INFO - PROCESS | 23458 | |0;dojo.html;2898.869550870211;2902.811317264376;2932.252275669704;2956.985215073923;2967.2730181105617;5108.616853735975;5122.282880396748;5169.483051694829;5215.374155101384;5217.054302082347;5180.948190518094;5192.117340052191;5230.34620672416;5244.449332820047;5320.521153096221;4475.149721552911;4743.90512189756;4783.521647835223;4812.181929072049;4823.589994850442;4852.960830804703;4864.343313652647;4895.975520122394;4918.926216106761;4940.2342636891335;4697.788599513047;4727.57451829337;4728.338032675429;4792.424909010906;4836.105320515716;4816.301636262722;4822.758862056883;4861.416630004387;4897.094037603055;4900.607951363882;4729.929051064202;4773.71357718538;4784.521547845223;4801.8079276828885;4835.6131509479155;5044.243363495505;5083.415407228179;5261.184516399964;5284.973575132138;5337.70642614656;5523.116301391758;5593.692346920918;5611.943880561183;5624.437556244343;5703.914441283384;5623.634463759842;5635.6055076144685;5646.6894320812335;5649.067903795869;5651.406602306781;5071.721055341918;5279.498447647467;5288.814891478818;5292.311999440087;5347.1979203119845;5556.583256255797;5623.0721930880945;5689.374168841424;5693.918155550515;5794;5466.426025267289;5500.614956952975;5503.11950087984;5504.697241651667;5511.421300763443;5512.4211957743855;5564.4991950724625;5571.860703482445;5584.609077364546;5642.4075472075665;5386.407495175527;5422.810201642924;5424.294841670558;5508.834734957958;5512.118061110203;5489.34127904654;5497.285352904097;5501.174823776466;5506.614536982373;5506.64206826563;4310.978445107817;4311.396404503372;4311.6335111515245;4316.827326906889;4316.956830431655;3831.942520862189;3851.2297540492013;3866.2074274773604;3930.8820735377985;3945.6448919597374;5275.894482110336;5320.068987927098;5320.494553017457;5326.307580014573;5378.354597448253;5559.221708960748;5587.692676902728;5588.413216612278;5592.356878958891;5592.86017849557;5017.84946451607;5052.343195384577;5057.393112826411;5107.540321371094;5111.335526381621;4720.527947205252;4723.905521889543;4834.540718631724;4840.83057093;4845.394325709286;5753.108268218517;5785.71071446426;5807.94192058074;5810.622309549865;5817.854553636193;5596.552275818006;5610.943890561042;5615.578831587565;5670.943290567042;5681.17622944679;5561.610687251854;5764.884702305846;5790.739416726173;5791.362950075572;5818.738156782871;5373.489518495737;5387.868547605047;5458.317710286215;5480.671159730269;5566.944330556805;5547.972260138835;5576.0799468088935;5590;5590.189422533791;5594.356648985418;5374.247605335178;5436.53789427903;5453.182022696627;5454.072807622634;5507.972460137674;5265.183896496049;5305.230741542532;5387.138057910715;5448.073827449264;5463.289772329572;5475.151351540518;5482.451754824486;5484.561235101102;5489.066858634122;5544.390117087037;5510.283663123929;5545.112781954868;5549.306336707911;5551.25058117149;5553.814391960896;5245.737713114406;5293.894122117613;5325.360956685223;5379.031774280667;5391.29913111293 12:35:58 INFO - PROCESS | 23458 | |1;ext.html;570.5293133165139;585.7217821534774;587.468341151258;606.6411238825032;624.0420953835862;32140.67859321406;32908;35327.116822079464;35412.64587354126;35417.46873796895;43235;44220;44229.336559951626;48364.75817620916;48474;8950.999999999984;9060.77348066297;9063.909360906406;9090.863637045417;9094.909050909473;9002.144796244347;9072.8639070414;9079.773005674844;9099.772505687377;9101.36290459668;9078.591463384164;9109.772255693595;9119.726408207764;9124.178823905848;9130.132637399436;9033.683821066264;9079.182873541347;9090.409123407024;9095.772605684844;9101.40840845343;9030.051844556358;9101.135392137736;9105.90729112504;9109.635614575409;9114.589843456994;43286.78356608228;43603.34594981078;43620.345694814605;43652.781736091434;43655.78172109151;3732.6267373262726;3768.057985503624;3866.2460820140086;3966.36538153894;3996.980015099935;32646.836765816257;33363.83318083394;33365.83317083423;33893.6610633893;34215;4101.179764047202;4145.8963525911795;4225.91548169038;4348.086901750637;4362.607365337135;341024;342192;342664;345092;346336;57900;58174;58231.41768582345;58247.70876145592;58343.70828145832;61238.69380653068;61337;61488;61544.69227653922;61549;16187.352505899868;16345;16366.345346186019;16371.099589522453;16379.83620163783;12489.125761196628;12503.374831258401;12512.937435312766;12540.122191446511;12546.87453125457;13794.310284485735;16589.91705041467;16647.50057498277;16723.581910452336;16833.242504087102;5103.988646698392;5726.112452569859;5834.212381328552;5895.94104058954;6182.598131121463;909.5725009245645;1014.5282443663584;1037.662759603117;1047.251215380991;1048.397171626318;31083.378332433225;32004.35991280208;32068.19829504281;32091.839540802146;32240.936197819105;1080.4813689429118;1113.9721506962392;1121.2095472691733;1134.3534185514177;1150.8618965724168;16284.592885177964;16649.33402663904;16672.666546669;16777.412790552273;16866.83133168677;545158;548372;549161;549717;550326;58250.41749582535;58290.417095828496;58333.70833145892;58384;58424;1194.2118201986648;1232.9445174967148;1287.2212311551564;1300.3563236198142;1317.4927652853528;29767.851160744056;31778.523322149726;31799.6820031806;34049.65950340465;34699.755818009464;54606.45393546014;54940.72529637326;55097.17354239609;55153.44846551483;55265.44734552603;484133;486804;487896;488271;488272;27647.170584882486;28149;28434.715652843206;41191.382129268684;41567.37648935208;46929.29606055844;47706;49179.508204917496;51566;51776.74111629418;40506.79746601248;41010.79494602508;41293.58706412897;41463.37804932989;43311.35032974445;41184.79407602943;41889.58110418857;41912.790436047624;42526.149477010906;43295.783521082194;40583.1883362337;41127.1774564513;42106.789466052476;42115.368269475366;42328.78835605802;34496.48255276223;36886;37261.90119086844;37298.25403491969;37624.811875940446;26427;27852.582211266443;28030.579541307303;28256.85871570629;28289.71710282871 12:35:58 INFO - PROCESS | 23458 | |2;jquery.html;366.6645019806877;379.3229086081345;386.312363992094;390.5177106273752;412.25587813995725;14384.640383990392;18411.355602553915;19150.80849191506;19409.514762130955;19719.408417747454;17500.299988000465;18295.634087318245;18651.813481865178;18898.905505472452;18903;5617.747201375948;5893.734781934823;5898.115282707586;5898.8230353089475;5904.143899134623;4072.1448495815916;4381.255186618267;4427.734335939854;5766.077427611583;5850.76596936122;6343.365663433643;6415.615063096206;6518.641474718888;6526.379993900596;6528.37980391862;6232.968835155841;6471.482281417499;6492.058651495554;6501.317361677003;6516.837079073014;5730.312362516483;5734.168545560912;5735.082386818089;5737.856553586152;5741.425857414267;14715.264236788225;16366.590835229095;21955.890220548954;22708.77291227083;22825.20111796079;2140.3257973738223;2340.9648855267183;2364.3498038039506;2419.4314336130997;2839.2901774556362;9781.217502599775;10408.791824163474;10972.341659500455;11005.119590432747;11211.775764484664;1801.8108098649716;1812.0939530234882;1845.1235663060074;1862.990685046566;1888.6978083506574;79107.20892791056;79237;79846.20153798445;79925;85829.57085214533;10865.891341086646;11117;11223.775524489465;11408.600698975495;11559.479823407966;16110.838891611169;16123.516294511184;16166.110863902599;16185.676286474205;16189;8113.350931925432;8173.918260817316;8329.208725171098;8375.455595386402;8408.453450525696;7176.856462870714;7350.558966462029;7397.149327827368;7572.39420846331;7584.241575842371;4829.044237083986;4884.535969082932;4917.213245880642;4930.556249937523;5011.3986321640905;1969.5666953270259;1972.4082775167392;2030.1175672507643;2044.4479990402508;2055.9177632894816;831.2020460358003;941.1764705882352;1011.2718842433436;1044.1125043712784;1055.7413433708791;18537.53656158607;18934.43196704101;19137.904310478636;19446.611067778565;19457.805421945883;939.7979434421633;965.5510187762724;965.6571916969375;1010.3735683876043;1031.3863251365426;7972.2824945755165;10301.330413523097;10632.255742098134;10819.729506762236;11351.37567433799;436486;437794;439936;440107;445381;92174.53912730393;92355;92873;95372;96186.51906740421;1021.6781713760141;1040.2250323509033;1049.8110340138849;1063.1494804156644;1065.3181963543338;17226;17631.382901598383;18529.90735046316;18600.34898778536;18612.5346866324;39591;41606.58393416027;42762.78618606887;43291.78354108209;43768;51921.48078519166;52966.735166323924;58850.11724824217;59526.404735953816;59580;6199.845003874759;7464.328210461084;7883.605819708877;8511.446755960842;8632.223099921037;13206.207627542379;13260.270685112411;13855.37650805696;13860.237686927316;13992.650183745487;10853.78292434131;10909.236353455182;10917.617883374043;11039.172062095535;11407.486663100346;11188.216824822184;11515.481803318704;11639.709007274885;11951.820722689341;11969.461374238354;6170.568060235741;9959.502024898871;11210.88789112131;11333.26333788301;11801.763964720829;7811.218878112143;8068.314193293636;8141.307988820779;8261.421700481149;8379.07830138672;8508.677165822563;11073.833892491459;11162.49768760424;11334.206605537533;11439.885601144215 12:35:58 INFO - PROCESS | 23458 | |3;mootools.html;1307.594645659845;1443.9711205775884;1502.286413953372;1610.7744915711794;1758.6131051168738;7105.822354441141;8486.575671216438;8780.385373023892;8805.779855503615;9062.093790620935;8815.338849586291;8882.245009174228;8890.199882010618;8897.1102889711;8908.777280567989;2377.3699969508093;2399.9760002399926;2402.8197885158684;2405.3144853716694;2407.350015495815;2336.334144768741;2359.2568340972625;2395.6646069550275;2401.807855371566;2402;2359.162497313455;2369.7037870266217;2387.1048356866177;2402.2793162051403;2409.3253888911045;2315.131825565413;2332.1371092695726;2336.2523992322463;2336.649502574619;2362.65741467488;2278.441781763462;2303.976960230393;2317.571249318881;2317.6755254264417;2317.7913987741185;8835.867461988075;8896.733098007071;8900.554972251426;8916.46501209923;8931.687390941286;5033.169527028036;5189.351331083614;5191;5284.682919024871;5286.920696189561;3213.983930080358;3371.561696979377;3405.6083550391772;3424.6404127566498;3429.657034296575;1061.8638631162694;1089.8637670291214;1096.1504833753825;1116.1684545013936;1116.8883111688847;12263.75472490554;12264.264144151379;12315.93842030784;12348.444320005621;12364.134510584263;4379.167958087953;4446.911061778746;4573.588377046015;4657.441107067174;4685.20351540239;9640.566174522022;9658.323917325719;9666;9666.081722236377;9681.080297371738;5266.947330526722;5300.70846103468;5308.336457942757;5312.5218730314455;5315.548178404802;4154.979225103855;4268.466441694788;4683.391159149289;4736.526347365305;4989.600831933437;3808.542974842981;3821.560520540118;3890.105275786585;3938.5864484229314;3946.1121247719034;1107.186218129674;1114.0474893965704;1125.2123513540555;1126.6845283320683;1141.1384404774342;928.7863791328033;936.1995493852794;963.5278713430368;969.0551712080664;994.3387647214521;5761.798337058183;5956.463918247378;6050.213472248667;6143.723532440961;6172.290186628506;480.62991496547465;483.2823257462665;486.10071367968976;486.5280677742584;487.1961263914569;4136.255474014646;4143.233501802176;4149.211649786531;4151.813168407429;4209.536950935395;10151.390916544884;10521.789564208826;10525.315854469434;10529.315594486334;10604.522796474177;10445.373277603216;10460.947695261475;10475.214358923111;10480;10483.68548943533;7772.222777722182;7888.1323054463965;8127.0653874803975;8138.145494723087;8298.875516867252;5828.533717302521;5947.345791962967;6013.128096425906;6101.786437474844;6197.4422301991235;9872.802543949225;9874.753131171778;9908.058734420218;9944.950275248577;10035.24735644844;9662.806743865223;10392.324498907547;10403.271770975958;10403.94798026005;10409;6621.933780662324;6806.6256355900905;6809.89785153233;7733.304002639789;7873.173316801883;7620.199879012624;7860.449768516149;7968.322692571196;8078.87881681787;8346.165383461605;7537.057867766529;7699.037620297463;7735.149133595188;7833.882491762514;7848.64681089341;7225.205227424874;7516.5114267572435;7585.279398457358;7603.847923041619;7766.805829854299;6934.202566704894;7042.859142817012;7050.083489146378;7052.576845389293;7053.329933656294;5043.2687260347775;5047.772850221822;5059.898802023865;5139.941546539971;5286.947130528645;4977.776000079933;5000.374953130859;5132.6150538709;5133.614978876524;5151.124308867426 12:35:58 INFO - PROCESS | 23458 | |4;prototype.html;305.8987644479873;313.8477838248449;319.5957114250475;326.68801294763506;329.84662132108565;5297.629165958385;5323.467653234679;5345.705986170759;5351.812686555972;5368.731563421833;5245;5262.763175657095;5313.442088580691;5327.627066105364;5338.91991620126;3985.0435895385117;4080.510338759353;4120.876373708794;4165.896037550052;4171.478565179353;4169.895752606179;4171.749695018293;4189.7695626740515;4217.789110544476;4259.531451540328;4149.751014939098;4155.106652069804;4155.958440415588;4158.792060396983;4180.665546756268;3895.5325360956585;3909.687225022006;4123.505179378464;4144.171165766828;4184.8744537663915;3675.8162091895565;3678.6137455567045;3693.2059607184583;3693.630636936312;3696.6488183622514;5117.948820511784;5124.385073791132;5130.692158470503;5142.665726727751;5148.2535032420465;4439.866803995886;4677.50886156952;4756.453007904101;4760.714357138583;4776.47458779534;5502.449755024506;5503.697296648683;5505.5410316266225;5513.669179849222;5515.420880807497;4009.298372784751;4013.9598604013877;4036.798160092013;4043.3126368517424;4063.674906007512;5466.835994920159;5688.516476099537;5700.629459085146;5826.766929322822;5832.854178645525;4063.1264278180333;4081.918361632751;4082.1427500225286;4083.4079058536345;4090.877273681794;4139.834406623761;4140.37894315849;4144.129732756155;4144.461220041375;4146.792660366969;4554.701909955646;4701.4358277006295;4723.645726570521;4733.337332773414;4738.928916066262;5520.779168833282;5521.309836270466;5529.917051244234;5552.222688823568;5564.860878478071;1413.3569226002144;1429.992850035764;1431.7566013777682;1432.5630682641686;1433.7705967045222;874.5015341255423;930.3859452761145;931.5063016601213;947.1806887042659;949.852772820214;5132.409772876093;5147.382314122329;5315.734213289397;5342.946570534323;5396.892062158813;5671.971640141773;5693.259876216065;5708.942910570924;5721.8569535761935;5731.398203188689;5175.197844334134;5336.439673834269;5345.9732701337025;5361.731913404315;5400.432954539795;2977.359867628427;2999.580058791771;3010.142109498826;3018.3963207358615;3032.499637559778;5830.038043722823;5831.329397119301;5848.795292164754;5855.151003104526;5877.9118313225335;5551.805686800943;5733.655980641175;5790.276215473066;5865.824025279248;5917.733701983421;5943.58394912352;5947.256592925884;5955.642661440241;5963.373845746221;5975.416514623628;5518.53092487127;5693.202951586864;5705.543556515552;5768.971155144198;5778.739956701875;5652.858678532905;5661.518770904519;5680.460356266148;5680.630759000652;5682.659040457585;5896.587238893237;5903.557233207613;5942.702864856827;5963.552733544915;5993.250843644544;3974.4237085623;4026.275270451347;4079.2051497342263;4094.795260237036;4122.505299364096;5718.542516598745;5732.455416735404;5732.627379220337;5744.133156723998;5775.451332123442;5648.774049037993;5699.116636921284;5713.257276554022;5714.942850571441;5730.942690573041;5417.377001644862;5551.084071128219;5588.832335029955;5611.607187496836;5614.2701448811395;5588.3573389060775;5598.972005139948;5603.551715862803;5667.971660141673;5687.1753595729215;5452.636840789803;5463.562914966873;5561.694106824163;5585.5531557476115;5645.689487078086;5419.539339156058;5419.701916394636;5480.3971563128825;5485.286912701324;5532.616845788553 12:35:58 INFO - PROCESS | 23458 | |5;yui.html;689.2900312677943;698.5703792167818;698.7030512032386;746.7050515046557;774.3766268154135;14853.480128195515;15734;16059.759103613454;16087.59781005474;16113.75829362559;15393.076415415055;15564.14397208153;15650.686986260267;15659.373625054985;15718.921405392957;664.0603545982453;787.232448362846;796.6654005317752;798.3373799746197;799.588212070784;660.5013215022651;662.8110988368315;663.7909058646535;779.6569509415867;790.644210105452;829.3613917283687;836.2139588786551;837.2464781696461;837.9944067119451;838.5010918503481;819.5574389829485;824.118193532923;824.8680211166214;826.2481142160635;829.8257365953157;501.4605162152194;503.5769953239297;505.55511150187965;608.3156448994881;610.6122612141278;13197.142185757895;14743.557693269218;15262.542123736306;15353.309101090477;16051.919740401223;14472.85527144736;14782.48261310849;15366.846331536653;15465.149416782073;15634.45279415215;11584.594539191172;11603.361815100166;11714.180007399485;11848.644540663709;11919.821202681967;3839.3856982882603;3848.326542855017;3871;3886.222755448893;3957.28768821612;83228.58385708093;83923;84529.99999999939;85010.99999999937;85906.57046714726;10351.792964140675;10428.165746740242;11582.189246752814;11606.24559403636;12351.38243087842;23264.4183895404;23297.30108096726;23336.883315583655;23409.531809364056;23457.7654223459;8069.475484093515;8709.346798990102;8967.596458159398;8987.41581797181;8996;4708.929366059512;4824.903501930012;4970.453250142481;5000.174971129795;5094.5669618082875;3568.91077723059;3669.94495082574;3704.388775852008;3706.221693444353;3724.640506215266;574.2362657665295;580.1095318685797;584.231735268121;593.5340757505337;593.9109133629904;575.9862641750549;632.6836581709146;641.2369280556123;702.7575486457266;707.8195060259601;8665.696700615448;9232.538373081454;9235.538223088819;9396.201322887495;9539.904600953902;656.7504348347597;667.7462564225564;672.862063277027;673.7641825361085;678.3318431345122;4295;4875.366202393737;4938.283948827472;5081.907389911113;5238.842834714965;128601;130043;130813.34593326972;131154;135026.324868377;105655.47172264243;107828;108730;111605;111939;95990;96479.51760241154;96862.51568742111;99238.54188019584;102282;9276.25789936817;9688.722538001266;9760.105159382167;9785.525452702368;9813.11681948628;46760.7661961688;56198;56259.43740562705;56754.716226418604;57822.13266800917;65595;72519.63740181265;73453;74754.62622686852;78215.60892195502;13188.80216796768;13244.337783111;13266.86733132695;13519.932400337935;13608.659783505096;13908.860911390757;14124.43502259898;14141.292935352985;14267.857321427067;14327.35526901271;12851.485940562647;13008.674783130118;13014.4143513544;13097.869021309665;14083.436662533384;11147.554097835995;11317.830232546354;11341.432928353384;11542.94228528852;12486.37568121572;11488.195826292414;11588.942055290006;11978.46096925658;12627.93686031564;12673.556425525063;9601.279904007368;10167.237457190888;10365.63720269787;10581.748465498122;10832.67501974942;9322.207612353026;10675.89324106749;10733.248672592843;10735.838962415726;11031.724206894893 12:35:58 INFO - PROCESS | 23458 | __end_tp_report 12:35:58 INFO - PROCESS | 23458 | __start_cc_report 12:35:58 INFO - PROCESS | 23458 | _x_x_mozilla_cycle_collect,1013 12:35:59 INFO - PROCESS | 23458 | __end_cc_report 12:35:59 INFO - PROCESS | 23458 | __startTimestamp1474486558989__endTimestamp 12:35:59 INFO - PROCESS | 23458 | 12:35:59 INFO - PROCESS | 23458 | ------- Summary: start ------- 12:35:59 INFO - PROCESS | 23458 | Number of tests: 6 12:35:59 INFO - PROCESS | 23458 | 12:35:59 INFO - PROCESS | 23458 | [#0] dojo.html Cycles:165 Average:5185.52 Median:5379.03 stddev:585.22 (10.9%) stddev-sans-first:558.85 12:35:59 INFO - PROCESS | 23458 | Values: 2898.9 2902.8 2932.3 2957.0 2967.3 5108.6 5122.3 5169.5 5215.4 5217.1 5180.9 5192.1 5230.3 5244.4 5320.5 4475.1 4743.9 4783.5 4812.2 4823.6 4853.0 4864.3 4896.0 4918.9 4940.2 4697.8 4727.6 4728.3 4792.4 4836.1 4816.3 4822.8 4861.4 4897.1 4900.6 4729.9 4773.7 4784.5 4801.8 4835.6 5044.2 5083.4 5261.2 5285.0 5337.7 5523.1 5593.7 5611.9 5624.4 5703.9 5623.6 5635.6 5646.7 5649.1 5651.4 5071.7 5279.5 5288.8 5292.3 5347.2 5556.6 5623.1 5689.4 5693.9 5794.0 5466.4 5500.6 5503.1 5504.7 5511.4 5512.4 5564.5 5571.9 5584.6 5642.4 5386.4 5422.8 5424.3 5508.8 5512.1 5489.3 5497.3 5501.2 5506.6 5506.6 4311.0 4311.4 4311.6 4316.8 4317.0 3831.9 3851.2 3866.2 3930.9 3945.6 5275.9 5320.1 5320.5 5326.3 5378.4 5559.2 5587.7 5588.4 5592.4 5592.9 5017.8 5052.3 5057.4 5107.5 5111.3 4720.5 4723.9 4834.5 4840.8 4845.4 5753.1 5785.7 5807.9 5810.6 5817.9 5596.6 5610.9 5615.6 5670.9 5681.2 5561.6 5764.9 5790.7 5791.4 5818.7 5373.5 5387.9 5458.3 5480.7 5566.9 5548.0 5576.1 5590.0 5590.2 5594.4 5374.2 5436.5 5453.2 5454.1 5508.0 5265.2 5305.2 5387.1 5448.1 5463.3 5475.2 5482.5 5484.6 5489.1 5544.4 5510.3 5545.1 5549.3 5551.3 5553.8 5245.7 5293.9 5325.4 5379.0 5391.3 12:35:59 INFO - PROCESS | 23458 | 12:35:59 INFO - PROCESS | 23458 | [#1] ext.html Cycles:180 Average:61968.93 Median:42111.08 stddev:124199.49 (294.9%) stddev-sans-first:124462.35 12:35:59 INFO - PROCESS | 23458 | Values: 570.5 585.7 587.5 606.6 624.0 32140.7 32908.0 35327.1 35412.6 35417.5 43235.0 44220.0 44229.3 48364.8 48474.0 8951.0 9060.8 9063.9 9090.9 9094.9 9002.1 9072.9 9079.8 9099.8 9101.4 9078.6 9109.8 9119.7 9124.2 9130.1 9033.7 9079.2 9090.4 9095.8 9101.4 9030.1 9101.1 9105.9 9109.6 9114.6 43286.8 43603.3 43620.3 43652.8 43655.8 3732.6 3768.1 3866.2 3966.4 3997.0 32646.8 33363.8 33365.8 33893.7 34215.0 4101.2 4145.9 4225.9 4348.1 4362.6 341024.0 342192.0 342664.0 345092.0 346336.0 57900.0 58174.0 58231.4 58247.7 58343.7 61238.7 61337.0 61488.0 61544.7 61549.0 16187.4 16345.0 16366.3 16371.1 16379.8 12489.1 12503.4 12512.9 12540.1 12546.9 13794.3 16589.9 16647.5 16723.6 16833.2 5104.0 5726.1 5834.2 5895.9 6182.6 909.6 1014.5 1037.7 1047.3 1048.4 31083.4 32004.4 32068.2 32091.8 32240.9 1080.5 1114.0 1121.2 1134.4 1150.9 16284.6 16649.3 16672.7 16777.4 16866.8 545158.0 548372.0 549161.0 549717.0 550326.0 58250.4 58290.4 58333.7 58384.0 58424.0 1194.2 1232.9 1287.2 1300.4 1317.5 29767.9 31778.5 31799.7 34049.7 34699.8 54606.5 54940.7 55097.2 55153.4 55265.4 484133.0 486804.0 487896.0 488271.0 488272.0 27647.2 28149.0 28434.7 41191.4 41567.4 46929.3 47706.0 49179.5 51566.0 51776.7 40506.8 41010.8 41293.6 41463.4 43311.4 41184.8 41889.6 41912.8 42526.1 43295.8 40583.2 41127.2 42106.8 42115.4 42328.8 34496.5 36886.0 37261.9 37298.3 37624.8 26427.0 27852.6 28030.6 28256.9 28289.7 12:35:59 INFO - PROCESS | 23458 | 12:35:59 INFO - PROCESS | 23458 | [#2] jquery.html Cycles:180 Average:27439.76 Median:372.99 stddev:72906.29 (19546.3%) stddev-sans-first:73082.47 12:35:59 INFO - PROCESS | 23458 | Values: 366.7 379.3 386.3 390.5 412.3 14384.6 18411.4 19150.8 19409.5 19719.4 17500.3 18295.6 18651.8 18898.9 18903.0 5617.7 5893.7 5898.1 5898.8 5904.1 4072.1 4381.3 4427.7 5766.1 5850.8 6343.4 6415.6 6518.6 6526.4 6528.4 6233.0 6471.5 6492.1 6501.3 6516.8 5730.3 5734.2 5735.1 5737.9 5741.4 14715.3 16366.6 21955.9 22708.8 22825.2 2140.3 2341.0 2364.3 2419.4 2839.3 9781.2 10408.8 10972.3 11005.1 11211.8 1801.8 1812.1 1845.1 1863.0 1888.7 79107.2 79237.0 79846.2 79925.0 85829.6 10865.9 11117.0 11223.8 11408.6 11559.5 16110.8 16123.5 16166.1 16185.7 16189.0 8113.4 8173.9 8329.2 8375.5 8408.5 7176.9 7350.6 7397.1 7572.4 7584.2 4829.0 4884.5 4917.2 4930.6 5011.4 1969.6 1972.4 2030.1 2044.4 2055.9 831.2 941.2 1011.3 1044.1 1055.7 18537.5 18934.4 19137.9 19446.6 19457.8 939.8 965.6 965.7 1010.4 1031.4 7972.3 10301.3 10632.3 10819.7 11351.4 436486.0 437794.0 439936.0 440107.0 445381.0 92174.5 92355.0 92873.0 95372.0 96186.5 1021.7 1040.2 1049.8 1063.1 1065.3 17226.0 17631.4 18529.9 18600.3 18612.5 39591.0 41606.6 42762.8 43291.8 43768.0 51921.5 52966.7 58850.1 59526.4 59580.0 6199.8 7464.3 7883.6 8511.4 8632.2 13206.2 13260.3 13855.4 13860.2 13992.7 10853.8 10909.2 10917.6 11039.2 11407.5 11188.2 11515.5 11639.7 11951.8 11969.5 6170.6 9959.5 11210.9 11333.3 11801.8 7811.2 8068.3 8141.3 8261.4 8379.1 8508.7 11073.8 11162.5 11334.2 11439.9 12:35:59 INFO - PROCESS | 23458 | 12:35:59 INFO - PROCESS | 23458 | [#3] mootools.html Cycles:180 Average:5695.64 Median:4994.99 stddev:3235.42 (64.8%) stddev-sans-first:3227.68 12:35:59 INFO - PROCESS | 23458 | Values: 1307.6 1444.0 1502.3 1610.8 1758.6 7105.8 8486.6 8780.4 8805.8 9062.1 8815.3 8882.2 8890.2 8897.1 8908.8 2377.4 2400.0 2402.8 2405.3 2407.4 2336.3 2359.3 2395.7 2401.8 2402.0 2359.2 2369.7 2387.1 2402.3 2409.3 2315.1 2332.1 2336.3 2336.6 2362.7 2278.4 2304.0 2317.6 2317.7 2317.8 8835.9 8896.7 8900.6 8916.5 8931.7 5033.2 5189.4 5191.0 5284.7 5286.9 3214.0 3371.6 3405.6 3424.6 3429.7 1061.9 1089.9 1096.2 1116.2 1116.9 12263.8 12264.3 12315.9 12348.4 12364.1 4379.2 4446.9 4573.6 4657.4 4685.2 9640.6 9658.3 9666.0 9666.1 9681.1 5266.9 5300.7 5308.3 5312.5 5315.5 4155.0 4268.5 4683.4 4736.5 4989.6 3808.5 3821.6 3890.1 3938.6 3946.1 1107.2 1114.0 1125.2 1126.7 1141.1 928.8 936.2 963.5 969.1 994.3 5761.8 5956.5 6050.2 6143.7 6172.3 480.6 483.3 486.1 486.5 487.2 4136.3 4143.2 4149.2 4151.8 4209.5 10151.4 10521.8 10525.3 10529.3 10604.5 10445.4 10460.9 10475.2 10480.0 10483.7 7772.2 7888.1 8127.1 8138.1 8298.9 5828.5 5947.3 6013.1 6101.8 6197.4 9872.8 9874.8 9908.1 9945.0 10035.2 9662.8 10392.3 10403.3 10403.9 10409.0 6621.9 6806.6 6809.9 7733.3 7873.2 7620.2 7860.4 7968.3 8078.9 8346.2 7537.1 7699.0 7735.1 7833.9 7848.6 7225.2 7516.5 7585.3 7603.8 7766.8 6934.2 7042.9 7050.1 7052.6 7053.3 5043.3 5047.8 5059.9 5139.9 5286.9 4977.8 5000.4 5132.6 5133.6 5151.1 12:35:59 INFO - PROCESS | 23458 | 12:35:59 INFO - PROCESS | 23458 | [#4] prototype.html Cycles:180 Average:4691.92 Median:5356.77 stddev:1383.68 (25.8%) stddev-sans-first:1347.83 12:35:59 INFO - PROCESS | 23458 | Values: 305.9 313.8 319.6 326.7 329.8 5297.6 5323.5 5345.7 5351.8 5368.7 5245.0 5262.8 5313.4 5327.6 5338.9 3985.0 4080.5 4120.9 4165.9 4171.5 4169.9 4171.7 4189.8 4217.8 4259.5 4149.8 4155.1 4156.0 4158.8 4180.7 3895.5 3909.7 4123.5 4144.2 4184.9 3675.8 3678.6 3693.2 3693.6 3696.6 5117.9 5124.4 5130.7 5142.7 5148.3 4439.9 4677.5 4756.5 4760.7 4776.5 5502.4 5503.7 5505.5 5513.7 5515.4 4009.3 4014.0 4036.8 4043.3 4063.7 5466.8 5688.5 5700.6 5826.8 5832.9 4063.1 4081.9 4082.1 4083.4 4090.9 4139.8 4140.4 4144.1 4144.5 4146.8 4554.7 4701.4 4723.6 4733.3 4738.9 5520.8 5521.3 5529.9 5552.2 5564.9 1413.4 1430.0 1431.8 1432.6 1433.8 874.5 930.4 931.5 947.2 949.9 5132.4 5147.4 5315.7 5342.9 5396.9 5672.0 5693.3 5708.9 5721.9 5731.4 5175.2 5336.4 5346.0 5361.7 5400.4 2977.4 2999.6 3010.1 3018.4 3032.5 5830.0 5831.3 5848.8 5855.2 5877.9 5551.8 5733.7 5790.3 5865.8 5917.7 5943.6 5947.3 5955.6 5963.4 5975.4 5518.5 5693.2 5705.5 5769.0 5778.7 5652.9 5661.5 5680.5 5680.6 5682.7 5896.6 5903.6 5942.7 5963.6 5993.3 3974.4 4026.3 4079.2 4094.8 4122.5 5718.5 5732.5 5732.6 5744.1 5775.5 5648.8 5699.1 5713.3 5714.9 5730.9 5417.4 5551.1 5588.8 5611.6 5614.3 5588.4 5599.0 5603.6 5668.0 5687.2 5452.6 5463.6 5561.7 5585.6 5645.7 5419.5 5419.7 5480.4 5485.3 5532.6 12:35:59 INFO - PROCESS | 23458 | 12:35:59 INFO - PROCESS | 23458 | [#5] yui.html Cycles:180 Average:22080.58 Median:25734.85 stddev:33361.34 (129.6%) stddev-sans-first:33416.27 12:35:59 INFO - PROCESS | 23458 | Values: 689.3 698.6 698.7 746.7 774.4 14853.5 15734.0 16059.8 16087.6 16113.8 15393.1 15564.1 15650.7 15659.4 15718.9 664.1 787.2 796.7 798.3 799.6 660.5 662.8 663.8 779.7 790.6 829.4 836.2 837.2 838.0 838.5 819.6 824.1 824.9 826.2 829.8 501.5 503.6 505.6 608.3 610.6 13197.1 14743.6 15262.5 15353.3 16051.9 14472.9 14782.5 15366.8 15465.1 15634.5 11584.6 11603.4 11714.2 11848.6 11919.8 3839.4 3848.3 3871.0 3886.2 3957.3 83228.6 83923.0 84530.0 85011.0 85906.6 10351.8 10428.2 11582.2 11606.2 12351.4 23264.4 23297.3 23336.9 23409.5 23457.8 8069.5 8709.3 8967.6 8987.4 8996.0 4708.9 4824.9 4970.5 5000.2 5094.6 3568.9 3669.9 3704.4 3706.2 3724.6 574.2 580.1 584.2 593.5 593.9 576.0 632.7 641.2 702.8 707.8 8665.7 9232.5 9235.5 9396.2 9539.9 656.8 667.7 672.9 673.8 678.3 4295.0 4875.4 4938.3 5081.9 5238.8 128601.0 130043.0 130813.3 131154.0 135026.3 105655.5 107828.0 108730.0 111605.0 111939.0 95990.0 96479.5 96862.5 99238.5 102282.0 9276.3 9688.7 9760.1 9785.5 9813.1 46760.8 56198.0 56259.4 56754.7 57822.1 65595.0 72519.6 73453.0 74754.6 78215.6 13188.8 13244.3 13266.9 13519.9 13608.7 13908.9 14124.4 14141.3 14267.9 14327.4 12851.5 13008.7 13014.4 13097.9 14083.4 11147.6 11317.8 11341.4 11542.9 12486.4 11488.2 11588.9 11978.5 12627.9 12673.6 9601.3 10167.2 10365.6 10581.7 10832.7 9322.2 10675.9 10733.2 10735.8 11031.7 12:35:59 INFO - PROCESS | 23458 | -------- Summary: end -------- 12:35:59 INFO - PROCESS | 23458 | 12:35:59 INFO - TEST-INFO | 23458: exit 0 12:35:59 INFO - TEST-OK | dromaeo_css | took 1115896ms 12:35:59 INFO - TEST-START | kraken 12:35:59 INFO - operating with platform_type : linux_ 12:35:59 INFO - Initialising browser for kraken test... 12:35:59 INFO - TEST-INFO | started process 23774 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfkkpud/profile http://localhost:43185/getInfo.html) 12:36:04 INFO - PROCESS | 23774 | __metrics Screen width/height:1600/1200 12:36:04 INFO - PROCESS | 23774 | colorDepth:24 12:36:04 INFO - PROCESS | 23774 | Browser inner width/height: 1024/697 12:36:04 INFO - PROCESS | 23774 | __metrics 12:36:04 INFO - PROCESS | 23774 | 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" 12:36:04 INFO - PROCESS | 23774 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:36:05 INFO - PROCESS | 23774 | console.error: PushService: 12:36:05 INFO - PROCESS | 23774 | stateChangeProcessEnqueue: Error transitioning state 12:36:05 INFO - PROCESS | 23774 | UnknownError 12:36:06 INFO - TEST-INFO | 23774: exit 0 12:36:06 INFO - Browser initialized. 12:36:06 INFO - Running cycle 1/1 for kraken test... 12:36:06 INFO - TEST-INFO | started process 23859 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfkkpud/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:36:18 INFO - PROCESS | 23859 | RSS: Main: 173969408 12:36:18 INFO - PROCESS | 23859 | 12:36:20 INFO - PROCESS | 23859 | Cycle 1(1): loaded http://localhost:43185/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43185/tests/kraken/driver.html?testName=audio-beat-detection) 12:36:21 INFO - PROCESS | 23859 | RSS: Main: 233431040 12:36:21 INFO - PROCESS | 23859 | 12:36:24 INFO - PROCESS | 23859 | Cycle 1(1): loaded http://localhost:43185/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43185/tests/kraken/driver.html?testName=audio-dft) 12:36:24 INFO - PROCESS | 23859 | RSS: Main: 217509888 12:36:24 INFO - PROCESS | 23859 | 12:36:27 INFO - PROCESS | 23859 | Cycle 1(1): loaded http://localhost:43185/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43185/tests/kraken/driver.html?testName=audio-fft) 12:36:28 INFO - PROCESS | 23859 | RSS: Main: 299536384 12:36:28 INFO - PROCESS | 23859 | 12:36:30 INFO - PROCESS | 23859 | Cycle 1(1): loaded http://localhost:43185/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43185/tests/kraken/driver.html?testName=audio-oscillator) 12:36:31 INFO - PROCESS | 23859 | RSS: Main: 208666624 12:36:31 INFO - PROCESS | 23859 | 12:36:33 INFO - PROCESS | 23859 | Cycle 1(1): loaded http://localhost:43185/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43185/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:36:34 INFO - PROCESS | 23859 | RSS: Main: 213200896 12:36:34 INFO - PROCESS | 23859 | 12:36:37 INFO - PROCESS | 23859 | Cycle 1(1): loaded http://localhost:43185/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43185/tests/kraken/driver.html?testName=imaging-darkroom) 12:36:37 INFO - PROCESS | 23859 | RSS: Main: 249667584 12:36:37 INFO - PROCESS | 23859 | 12:36:41 INFO - PROCESS | 23859 | Cycle 1(1): loaded http://localhost:43185/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43185/tests/kraken/driver.html?testName=imaging-desaturate) 12:36:41 INFO - PROCESS | 23859 | RSS: Main: 248930304 12:36:41 INFO - PROCESS | 23859 | 12:36:44 INFO - PROCESS | 23859 | Cycle 1(1): loaded http://localhost:43185/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43185/tests/kraken/driver.html?testName=json-parse-financial) 12:36:45 INFO - PROCESS | 23859 | RSS: Main: 248967168 12:36:45 INFO - PROCESS | 23859 | 12:36:46 INFO - PROCESS | 23859 | Cycle 1(1): loaded http://localhost:43185/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43185/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:36:47 INFO - PROCESS | 23859 | RSS: Main: 210993152 12:36:47 INFO - PROCESS | 23859 | 12:36:48 INFO - PROCESS | 23859 | Cycle 1(1): loaded http://localhost:43185/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43185/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:36:49 INFO - PROCESS | 23859 | RSS: Main: 217862144 12:36:49 INFO - PROCESS | 23859 | 12:36:51 INFO - PROCESS | 23859 | Cycle 1(1): loaded http://localhost:43185/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43185/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:36:52 INFO - PROCESS | 23859 | RSS: Main: 222498816 12:36:52 INFO - PROCESS | 23859 | 12:36:54 INFO - PROCESS | 23859 | Cycle 1(1): loaded http://localhost:43185/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43185/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:36:55 INFO - PROCESS | 23859 | RSS: Main: 223395840 12:36:55 INFO - PROCESS | 23859 | 12:36:58 INFO - PROCESS | 23859 | Cycle 1(1): loaded http://localhost:43185/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43185/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:36:58 INFO - PROCESS | 23859 | RSS: Main: 221691904 12:36:58 INFO - PROCESS | 23859 | 12:37:00 INFO - PROCESS | 23859 | Cycle 1(1): loaded http://localhost:43185/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43185/tests/kraken/driver.html?testName=ai-astar) 12:37:00 INFO - PROCESS | 23859 | RSS: Main: 272392192 12:37:00 INFO - PROCESS | 23859 | 12:37:00 INFO - PROCESS | 23859 | __start_tp_report 12:37:00 INFO - PROCESS | 23859 | _x_x_mozilla_page_load 12:37:00 INFO - PROCESS | 23859 | _x_x_mozilla_page_load_details 12:37:00 INFO - PROCESS | 23859 | |i|pagename|runs| 12:37:00 INFO - PROCESS | 23859 | |0;ai-astar;108;111;112;109;110;110;112;110;110;112 12:37:00 INFO - PROCESS | 23859 | |1;audio-beat-detection;152;121;123;180;119;120;118;117;148;122 12:37:00 INFO - PROCESS | 23859 | |2;audio-dft;161;161;162;161;160;162;159;161;160;161 12:37:00 INFO - PROCESS | 23859 | |3;audio-fft;75;77;78;106;76;77;76;77;98;77 12:37:00 INFO - PROCESS | 23859 | |4;audio-oscillator;83;82;124;83;82;85;103;82;82;113 12:37:00 INFO - PROCESS | 23859 | |5;imaging-gaussian-blur;117;116;117;117;116;117;117;117;117;116 12:37:00 INFO - PROCESS | 23859 | |6;imaging-darkroom;147;147;148;148;147;147;147;146;146;145 12:37:00 INFO - PROCESS | 23859 | |7;imaging-desaturate;95;95;96;96;96;95;95;96;96;96 12:37:00 INFO - PROCESS | 23859 | |8;json-parse-financial;53;52;50;58;52;51;52;51;52;52 12:37:00 INFO - PROCESS | 23859 | |9;json-stringify-tinderbox;60;60;61;61;60;61;61;61;61;61 12:37:00 INFO - PROCESS | 23859 | |10;stanford-crypto-aes;79;79;84;79;78;78;79;77;77;77 12:37:00 INFO - PROCESS | 23859 | |11;stanford-crypto-ccm;124;132;133;124;123;132;124;132;172;142 12:37:00 INFO - PROCESS | 23859 | |12;stanford-crypto-pbkdf2;162;165;168;163;166;164;162;162;162;160 12:37:00 INFO - PROCESS | 23859 | |13;stanford-crypto-sha256-iterative;65;66;65;64;64;64;64;65;64;66 12:37:00 INFO - PROCESS | 23859 | __end_tp_report 12:37:00 INFO - PROCESS | 23859 | __start_cc_report 12:37:00 INFO - PROCESS | 23859 | _x_x_mozilla_cycle_collect,1620 12:37:00 INFO - PROCESS | 23859 | __end_cc_report 12:37:00 INFO - PROCESS | 23859 | __startTimestamp1474486620726__endTimestamp 12:37:00 INFO - PROCESS | 23859 | 12:37:00 INFO - PROCESS | 23859 | ------- Summary: start ------- 12:37:00 INFO - PROCESS | 23859 | Number of tests: 14 12:37:00 INFO - PROCESS | 23859 | 12:37:00 INFO - PROCESS | 23859 | [#0] ai-astar Cycles:10 Average:110.40 Median:110.50 stddev:1.35 (1.2%) stddev-sans-first:1.12 12:37:00 INFO - PROCESS | 23859 | Values: 108.0 111.0 112.0 109.0 110.0 110.0 112.0 110.0 110.0 112.0 12:37:00 INFO - PROCESS | 23859 | 12:37:00 INFO - PROCESS | 23859 | [#1] audio-beat-detection Cycles:10 Average:132.00 Median:122.50 stddev:21.07 (17.2%) stddev-sans-first:21.07 12:37:00 INFO - PROCESS | 23859 | Values: 152.0 121.0 123.0 180.0 119.0 120.0 118.0 117.0 148.0 122.0 12:37:00 INFO - PROCESS | 23859 | 12:37:00 INFO - PROCESS | 23859 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 12:37:00 INFO - PROCESS | 23859 | Values: 161.0 161.0 162.0 161.0 160.0 162.0 159.0 161.0 160.0 161.0 12:37:00 INFO - PROCESS | 23859 | 12:37:00 INFO - PROCESS | 23859 | [#3] audio-fft Cycles:10 Average:81.70 Median:77.00 stddev:10.89 (14.1%) stddev-sans-first:11.28 12:37:00 INFO - PROCESS | 23859 | Values: 75.0 77.0 78.0 106.0 76.0 77.0 76.0 77.0 98.0 77.0 12:37:00 INFO - PROCESS | 23859 | 12:37:00 INFO - PROCESS | 23859 | [#4] audio-oscillator Cycles:10 Average:91.90 Median:82.00 stddev:15.62 (19.1%) stddev-sans-first:16.24 12:37:00 INFO - PROCESS | 23859 | Values: 83.0 82.0 124.0 83.0 82.0 85.0 103.0 82.0 82.0 113.0 12:37:00 INFO - PROCESS | 23859 | 12:37:00 INFO - PROCESS | 23859 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 12:37:00 INFO - PROCESS | 23859 | Values: 117.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 12:37:00 INFO - PROCESS | 23859 | 12:37:00 INFO - PROCESS | 23859 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 12:37:00 INFO - PROCESS | 23859 | Values: 147.0 147.0 148.0 148.0 147.0 147.0 147.0 146.0 146.0 145.0 12:37:00 INFO - PROCESS | 23859 | 12:37:00 INFO - PROCESS | 23859 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 12:37:00 INFO - PROCESS | 23859 | Values: 95.0 95.0 96.0 96.0 96.0 95.0 95.0 96.0 96.0 96.0 12:37:00 INFO - PROCESS | 23859 | 12:37:00 INFO - PROCESS | 23859 | [#8] json-parse-financial Cycles:10 Average:52.30 Median:52.00 stddev:2.16 (4.2%) stddev-sans-first:2.28 12:37:00 INFO - PROCESS | 23859 | Values: 53.0 52.0 50.0 58.0 52.0 51.0 52.0 51.0 52.0 52.0 12:37:00 INFO - PROCESS | 23859 | 12:37:00 INFO - PROCESS | 23859 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 12:37:00 INFO - PROCESS | 23859 | Values: 60.0 60.0 61.0 61.0 60.0 61.0 61.0 61.0 61.0 61.0 12:37:00 INFO - PROCESS | 23859 | 12:37:00 INFO - PROCESS | 23859 | [#10] stanford-crypto-aes Cycles:10 Average:78.70 Median:79.00 stddev:2.06 (2.6%) stddev-sans-first:2.18 12:37:00 INFO - PROCESS | 23859 | Values: 79.0 79.0 84.0 79.0 78.0 78.0 79.0 77.0 77.0 77.0 12:37:00 INFO - PROCESS | 23859 | 12:37:00 INFO - PROCESS | 23859 | [#11] stanford-crypto-ccm Cycles:10 Average:133.80 Median:132.00 stddev:14.69 (11.1%) stddev-sans-first:15.14 12:37:00 INFO - PROCESS | 23859 | Values: 124.0 132.0 133.0 124.0 123.0 132.0 124.0 132.0 172.0 142.0 12:37:00 INFO - PROCESS | 23859 | 12:37:00 INFO - PROCESS | 23859 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.40 Median:163.50 stddev:2.37 (1.4%) stddev-sans-first:2.46 12:37:00 INFO - PROCESS | 23859 | Values: 162.0 165.0 168.0 163.0 166.0 164.0 162.0 162.0 162.0 160.0 12:37:00 INFO - PROCESS | 23859 | 12:37:00 INFO - PROCESS | 23859 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:65.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 12:37:00 INFO - PROCESS | 23859 | Values: 65.0 66.0 65.0 64.0 64.0 64.0 64.0 65.0 64.0 66.0 12:37:00 INFO - PROCESS | 23859 | -------- Summary: end -------- 12:37:00 INFO - PROCESS | 23859 | 12:37:01 INFO - TEST-INFO | 23859: exit 0 12:37:01 INFO - TEST-OK | kraken | took 62085ms 12:37:01 INFO - SUITE-END | took 1177s 12:37:02 INFO - Completed test suite (00:19:38) 12:37:02 INFO - javascript benchmark 12:37:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2898.869550870211, 2902.811317264376, 2932.252275669704, 2956.985215073923, 2967.2730181105617, 5108.616853735975, 5122.282880396748, 5169.483051694829, 5215.374155101384, 5217.054302082347, 5180.948190518094, 5192.117340052191, 5230.34620672416, 5244.449332820047, 5320.521153096221, 4475.149721552911, 4743.90512189756, 4783.521647835223, 4812.181929072049, 4823.589994850442, 4852.960830804703, 4864.343313652647, 4895.975520122394, 4918.926216106761, 4940.2342636891335, 4697.788599513047, 4727.57451829337, 4728.338032675429, 4792.424909010906, 4836.105320515716, 4816.301636262722, 4822.758862056883, 4861.416630004387, 4897.094037603055, 4900.607951363882, 4729.929051064202, 4773.71357718538, 4784.521547845223, 4801.8079276828885, 4835.6131509479155, 5044.243363495505, 5083.415407228179, 5261.184516399964, 5284.973575132138, 5337.70642614656, 5523.116301391758, 5593.692346920918, 5611.943880561183, 5624.437556244343, 5703.914441283384, 5623.634463759842, 5635.6055076144685, 5646.6894320812335, 5649.067903795869, 5651.406602306781, 5071.721055341918, 5279.498447647467, 5288.814891478818, 5292.311999440087, 5347.1979203119845, 5556.583256255797, 5623.0721930880945, 5689.374168841424, 5693.918155550515, 5794.0, 5466.426025267289, 5500.614956952975, 5503.11950087984, 5504.697241651667, 5511.421300763443, 5512.4211957743855, 5564.4991950724625, 5571.860703482445, 5584.609077364546, 5642.4075472075665, 5386.407495175527, 5422.810201642924, 5424.294841670558, 5508.834734957958, 5512.118061110203, 5489.34127904654, 5497.285352904097, 5501.174823776466, 5506.614536982373, 5506.64206826563, 4310.978445107817, 4311.396404503372, 4311.6335111515245, 4316.827326906889, 4316.956830431655, 3831.942520862189, 3851.2297540492013, 3866.2074274773604, 3930.8820735377985, 3945.6448919597374, 5275.894482110336, 5320.068987927098, 5320.494553017457, 5326.307580014573, 5378.354597448253, 5559.221708960748, 5587.692676902728, 5588.413216612278, 5592.356878958891, 5592.86017849557, 5017.84946451607, 5052.343195384577, 5057.393112826411, 5107.540321371094, 5111.335526381621, 4720.527947205252, 4723.905521889543, 4834.540718631724, 4840.83057093, 4845.394325709286, 5753.108268218517, 5785.71071446426, 5807.94192058074, 5810.622309549865, 5817.854553636193, 5596.552275818006, 5610.943890561042, 5615.578831587565, 5670.943290567042, 5681.17622944679, 5561.610687251854, 5764.884702305846, 5790.739416726173, 5791.362950075572, 5818.738156782871, 5373.489518495737, 5387.868547605047, 5458.317710286215, 5480.671159730269, 5566.944330556805, 5547.972260138835, 5576.0799468088935, 5590.0, 5590.189422533791, 5594.356648985418, 5374.247605335178, 5436.53789427903, 5453.182022696627, 5454.072807622634, 5507.972460137674, 5265.183896496049, 5305.230741542532, 5387.138057910715, 5448.073827449264, 5463.289772329572, 5475.151351540518, 5482.451754824486, 5484.561235101102, 5489.066858634122, 5544.390117087037, 5510.283663123929, 5545.112781954868, 5549.306336707911, 5551.25058117149, 5553.814391960896, 5245.737713114406, 5293.894122117613, 5325.360956685223, 5379.031774280667, 5391.29913111293], "value": 5145.64538771871, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.5293133165139, 585.7217821534774, 587.468341151258, 606.6411238825032, 624.0420953835862, 32140.67859321406, 32908.0, 35327.116822079464, 35412.64587354126, 35417.46873796895, 43235.0, 44220.0, 44229.336559951626, 48364.75817620916, 48474.0, 8950.999999999984, 9060.77348066297, 9063.909360906406, 9090.863637045417, 9094.909050909473, 9002.144796244347, 9072.8639070414, 9079.773005674844, 9099.772505687377, 9101.36290459668, 9078.591463384164, 9109.772255693595, 9119.726408207764, 9124.178823905848, 9130.132637399436, 9033.683821066264, 9079.182873541347, 9090.409123407024, 9095.772605684844, 9101.40840845343, 9030.051844556358, 9101.135392137736, 9105.90729112504, 9109.635614575409, 9114.589843456994, 43286.78356608228, 43603.34594981078, 43620.345694814605, 43652.781736091434, 43655.78172109151, 3732.6267373262726, 3768.057985503624, 3866.2460820140086, 3966.36538153894, 3996.980015099935, 32646.836765816257, 33363.83318083394, 33365.83317083423, 33893.6610633893, 34215.0, 4101.179764047202, 4145.8963525911795, 4225.91548169038, 4348.086901750637, 4362.607365337135, 341024.0, 342192.0, 342664.0, 345092.0, 346336.0, 57900.0, 58174.0, 58231.41768582345, 58247.70876145592, 58343.70828145832, 61238.69380653068, 61337.0, 61488.0, 61544.69227653922, 61549.0, 16187.352505899868, 16345.0, 16366.345346186019, 16371.099589522453, 16379.83620163783, 12489.125761196628, 12503.374831258401, 12512.937435312766, 12540.122191446511, 12546.87453125457, 13794.310284485735, 16589.91705041467, 16647.50057498277, 16723.581910452336, 16833.242504087102, 5103.988646698392, 5726.112452569859, 5834.212381328552, 5895.94104058954, 6182.598131121463, 909.5725009245645, 1014.5282443663584, 1037.662759603117, 1047.251215380991, 1048.397171626318, 31083.378332433225, 32004.35991280208, 32068.19829504281, 32091.839540802146, 32240.936197819105, 1080.4813689429118, 1113.9721506962392, 1121.2095472691733, 1134.3534185514177, 1150.8618965724168, 16284.592885177964, 16649.33402663904, 16672.666546669, 16777.412790552273, 16866.83133168677, 545158.0, 548372.0, 549161.0, 549717.0, 550326.0, 58250.41749582535, 58290.417095828496, 58333.70833145892, 58384.0, 58424.0, 1194.2118201986648, 1232.9445174967148, 1287.2212311551564, 1300.3563236198142, 1317.4927652853528, 29767.851160744056, 31778.523322149726, 31799.6820031806, 34049.65950340465, 34699.755818009464, 54606.45393546014, 54940.72529637326, 55097.17354239609, 55153.44846551483, 55265.44734552603, 484133.0, 486804.0, 487896.0, 488271.0, 488272.0, 27647.170584882486, 28149.0, 28434.715652843206, 41191.382129268684, 41567.37648935208, 46929.29606055844, 47706.0, 49179.508204917496, 51566.0, 51776.74111629418, 40506.79746601248, 41010.79494602508, 41293.58706412897, 41463.37804932989, 43311.35032974445, 41184.79407602943, 41889.58110418857, 41912.790436047624, 42526.149477010906, 43295.783521082194, 40583.1883362337, 41127.1774564513, 42106.789466052476, 42115.368269475366, 42328.78835605802, 34496.48255276223, 36886.0, 37261.90119086844, 37298.25403491969, 37624.811875940446, 26427.0, 27852.582211266443, 28030.579541307303, 28256.85871570629, 28289.71710282871], "value": 20108.315079296444, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.6645019806877, 379.3229086081345, 386.312363992094, 390.5177106273752, 412.25587813995725, 14384.640383990392, 18411.355602553915, 19150.80849191506, 19409.514762130955, 19719.408417747454, 17500.299988000465, 18295.634087318245, 18651.813481865178, 18898.905505472452, 18903.0, 5617.747201375948, 5893.734781934823, 5898.115282707586, 5898.8230353089475, 5904.143899134623, 4072.1448495815916, 4381.255186618267, 4427.734335939854, 5766.077427611583, 5850.76596936122, 6343.365663433643, 6415.615063096206, 6518.641474718888, 6526.379993900596, 6528.37980391862, 6232.968835155841, 6471.482281417499, 6492.058651495554, 6501.317361677003, 6516.837079073014, 5730.312362516483, 5734.168545560912, 5735.082386818089, 5737.856553586152, 5741.425857414267, 14715.264236788225, 16366.590835229095, 21955.890220548954, 22708.77291227083, 22825.20111796079, 2140.3257973738223, 2340.9648855267183, 2364.3498038039506, 2419.4314336130997, 2839.2901774556362, 9781.217502599775, 10408.791824163474, 10972.341659500455, 11005.119590432747, 11211.775764484664, 1801.8108098649716, 1812.0939530234882, 1845.1235663060074, 1862.990685046566, 1888.6978083506574, 79107.20892791056, 79237.0, 79846.20153798445, 79925.0, 85829.57085214533, 10865.891341086646, 11117.0, 11223.775524489465, 11408.600698975495, 11559.479823407966, 16110.838891611169, 16123.516294511184, 16166.110863902599, 16185.676286474205, 16189.0, 8113.350931925432, 8173.918260817316, 8329.208725171098, 8375.455595386402, 8408.453450525696, 7176.856462870714, 7350.558966462029, 7397.149327827368, 7572.39420846331, 7584.241575842371, 4829.044237083986, 4884.535969082932, 4917.213245880642, 4930.556249937523, 5011.3986321640905, 1969.5666953270259, 1972.4082775167392, 2030.1175672507643, 2044.4479990402508, 2055.9177632894816, 831.2020460358003, 941.1764705882352, 1011.2718842433436, 1044.1125043712784, 1055.7413433708791, 18537.53656158607, 18934.43196704101, 19137.904310478636, 19446.611067778565, 19457.805421945883, 939.7979434421633, 965.5510187762724, 965.6571916969375, 1010.3735683876043, 1031.3863251365426, 7972.2824945755165, 10301.330413523097, 10632.255742098134, 10819.729506762236, 11351.37567433799, 436486.0, 437794.0, 439936.0, 440107.0, 445381.0, 92174.53912730393, 92355.0, 92873.0, 95372.0, 96186.51906740421, 1021.6781713760141, 1040.2250323509033, 1049.8110340138849, 1063.1494804156644, 1065.3181963543338, 17226.0, 17631.382901598383, 18529.90735046316, 18600.34898778536, 18612.5346866324, 39591.0, 41606.58393416027, 42762.78618606887, 43291.78354108209, 43768.0, 51921.48078519166, 52966.735166323924, 58850.11724824217, 59526.404735953816, 59580.0, 6199.845003874759, 7464.328210461084, 7883.605819708877, 8511.446755960842, 8632.223099921037, 13206.207627542379, 13260.270685112411, 13855.37650805696, 13860.237686927316, 13992.650183745487, 10853.78292434131, 10909.236353455182, 10917.617883374043, 11039.172062095535, 11407.486663100346, 11188.216824822184, 11515.481803318704, 11639.709007274885, 11951.820722689341, 11969.461374238354, 6170.568060235741, 9959.502024898871, 11210.88789112131, 11333.26333788301, 11801.763964720829, 7811.218878112143, 8068.314193293636, 8141.307988820779, 8261.421700481149, 8379.07830138672, 8508.677165822563, 11073.833892491459, 11162.49768760424, 11334.206605537533, 11439.885601144215], "value": 9082.172018756693, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1307.594645659845, 1443.9711205775884, 1502.286413953372, 1610.7744915711794, 1758.6131051168738, 7105.822354441141, 8486.575671216438, 8780.385373023892, 8805.779855503615, 9062.093790620935, 8815.338849586291, 8882.245009174228, 8890.199882010618, 8897.1102889711, 8908.777280567989, 2377.3699969508093, 2399.9760002399926, 2402.8197885158684, 2405.3144853716694, 2407.350015495815, 2336.334144768741, 2359.2568340972625, 2395.6646069550275, 2401.807855371566, 2402.0, 2359.162497313455, 2369.7037870266217, 2387.1048356866177, 2402.2793162051403, 2409.3253888911045, 2315.131825565413, 2332.1371092695726, 2336.2523992322463, 2336.649502574619, 2362.65741467488, 2278.441781763462, 2303.976960230393, 2317.571249318881, 2317.6755254264417, 2317.7913987741185, 8835.867461988075, 8896.733098007071, 8900.554972251426, 8916.46501209923, 8931.687390941286, 5033.169527028036, 5189.351331083614, 5191.0, 5284.682919024871, 5286.920696189561, 3213.983930080358, 3371.561696979377, 3405.6083550391772, 3424.6404127566498, 3429.657034296575, 1061.8638631162694, 1089.8637670291214, 1096.1504833753825, 1116.1684545013936, 1116.8883111688847, 12263.75472490554, 12264.264144151379, 12315.93842030784, 12348.444320005621, 12364.134510584263, 4379.167958087953, 4446.911061778746, 4573.588377046015, 4657.441107067174, 4685.20351540239, 9640.566174522022, 9658.323917325719, 9666.0, 9666.081722236377, 9681.080297371738, 5266.947330526722, 5300.70846103468, 5308.336457942757, 5312.5218730314455, 5315.548178404802, 4154.979225103855, 4268.466441694788, 4683.391159149289, 4736.526347365305, 4989.600831933437, 3808.542974842981, 3821.560520540118, 3890.105275786585, 3938.5864484229314, 3946.1121247719034, 1107.186218129674, 1114.0474893965704, 1125.2123513540555, 1126.6845283320683, 1141.1384404774342, 928.7863791328033, 936.1995493852794, 963.5278713430368, 969.0551712080664, 994.3387647214521, 5761.798337058183, 5956.463918247378, 6050.213472248667, 6143.723532440961, 6172.290186628506, 480.62991496547465, 483.2823257462665, 486.10071367968976, 486.5280677742584, 487.1961263914569, 4136.255474014646, 4143.233501802176, 4149.211649786531, 4151.813168407429, 4209.536950935395, 10151.390916544884, 10521.789564208826, 10525.315854469434, 10529.315594486334, 10604.522796474177, 10445.373277603216, 10460.947695261475, 10475.214358923111, 10480.0, 10483.68548943533, 7772.222777722182, 7888.1323054463965, 8127.0653874803975, 8138.145494723087, 8298.875516867252, 5828.533717302521, 5947.345791962967, 6013.128096425906, 6101.786437474844, 6197.4422301991235, 9872.802543949225, 9874.753131171778, 9908.058734420218, 9944.950275248577, 10035.24735644844, 9662.806743865223, 10392.324498907547, 10403.271770975958, 10403.94798026005, 10409.0, 6621.933780662324, 6806.6256355900905, 6809.89785153233, 7733.304002639789, 7873.173316801883, 7620.199879012624, 7860.449768516149, 7968.322692571196, 8078.87881681787, 8346.165383461605, 7537.057867766529, 7699.037620297463, 7735.149133595188, 7833.882491762514, 7848.64681089341, 7225.205227424874, 7516.5114267572435, 7585.279398457358, 7603.847923041619, 7766.805829854299, 6934.202566704894, 7042.859142817012, 7050.083489146378, 7052.576845389293, 7053.329933656294, 5043.2687260347775, 5047.772850221822, 5059.898802023865, 5139.941546539971, 5286.947130528645, 4977.776000079933, 5000.374953130859, 5132.6150538709, 5133.614978876524, 5151.124308867426], "value": 4494.390776695438, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.8987644479873, 313.8477838248449, 319.5957114250475, 326.68801294763506, 329.84662132108565, 5297.629165958385, 5323.467653234679, 5345.705986170759, 5351.812686555972, 5368.731563421833, 5245.0, 5262.763175657095, 5313.442088580691, 5327.627066105364, 5338.91991620126, 3985.0435895385117, 4080.510338759353, 4120.876373708794, 4165.896037550052, 4171.478565179353, 4169.895752606179, 4171.749695018293, 4189.7695626740515, 4217.789110544476, 4259.531451540328, 4149.751014939098, 4155.106652069804, 4155.958440415588, 4158.792060396983, 4180.665546756268, 3895.5325360956585, 3909.687225022006, 4123.505179378464, 4144.171165766828, 4184.8744537663915, 3675.8162091895565, 3678.6137455567045, 3693.2059607184583, 3693.630636936312, 3696.6488183622514, 5117.948820511784, 5124.385073791132, 5130.692158470503, 5142.665726727751, 5148.2535032420465, 4439.866803995886, 4677.50886156952, 4756.453007904101, 4760.714357138583, 4776.47458779534, 5502.449755024506, 5503.697296648683, 5505.5410316266225, 5513.669179849222, 5515.420880807497, 4009.298372784751, 4013.9598604013877, 4036.798160092013, 4043.3126368517424, 4063.674906007512, 5466.835994920159, 5688.516476099537, 5700.629459085146, 5826.766929322822, 5832.854178645525, 4063.1264278180333, 4081.918361632751, 4082.1427500225286, 4083.4079058536345, 4090.877273681794, 4139.834406623761, 4140.37894315849, 4144.129732756155, 4144.461220041375, 4146.792660366969, 4554.701909955646, 4701.4358277006295, 4723.645726570521, 4733.337332773414, 4738.928916066262, 5520.779168833282, 5521.309836270466, 5529.917051244234, 5552.222688823568, 5564.860878478071, 1413.3569226002144, 1429.992850035764, 1431.7566013777682, 1432.5630682641686, 1433.7705967045222, 874.5015341255423, 930.3859452761145, 931.5063016601213, 947.1806887042659, 949.852772820214, 5132.409772876093, 5147.382314122329, 5315.734213289397, 5342.946570534323, 5396.892062158813, 5671.971640141773, 5693.259876216065, 5708.942910570924, 5721.8569535761935, 5731.398203188689, 5175.197844334134, 5336.439673834269, 5345.9732701337025, 5361.731913404315, 5400.432954539795, 2977.359867628427, 2999.580058791771, 3010.142109498826, 3018.3963207358615, 3032.499637559778, 5830.038043722823, 5831.329397119301, 5848.795292164754, 5855.151003104526, 5877.9118313225335, 5551.805686800943, 5733.655980641175, 5790.276215473066, 5865.824025279248, 5917.733701983421, 5943.58394912352, 5947.256592925884, 5955.642661440241, 5963.373845746221, 5975.416514623628, 5518.53092487127, 5693.202951586864, 5705.543556515552, 5768.971155144198, 5778.739956701875, 5652.858678532905, 5661.518770904519, 5680.460356266148, 5680.630759000652, 5682.659040457585, 5896.587238893237, 5903.557233207613, 5942.702864856827, 5963.552733544915, 5993.250843644544, 3974.4237085623, 4026.275270451347, 4079.2051497342263, 4094.795260237036, 4122.505299364096, 5718.542516598745, 5732.455416735404, 5732.627379220337, 5744.133156723998, 5775.451332123442, 5648.774049037993, 5699.116636921284, 5713.257276554022, 5714.942850571441, 5730.942690573041, 5417.377001644862, 5551.084071128219, 5588.832335029955, 5611.607187496836, 5614.2701448811395, 5588.3573389060775, 5598.972005139948, 5603.551715862803, 5667.971660141673, 5687.1753595729215, 5452.636840789803, 5463.562914966873, 5561.694106824163, 5585.5531557476115, 5645.689487078086, 5419.539339156058, 5419.701916394636, 5480.3971563128825, 5485.286912701324, 5532.616845788553], "value": 4244.991794699358, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [689.2900312677943, 698.5703792167818, 698.7030512032386, 746.7050515046557, 774.3766268154135, 14853.480128195515, 15734.0, 16059.759103613454, 16087.59781005474, 16113.75829362559, 15393.076415415055, 15564.14397208153, 15650.686986260267, 15659.373625054985, 15718.921405392957, 664.0603545982453, 787.232448362846, 796.6654005317752, 798.3373799746197, 799.588212070784, 660.5013215022651, 662.8110988368315, 663.7909058646535, 779.6569509415867, 790.644210105452, 829.3613917283687, 836.2139588786551, 837.2464781696461, 837.9944067119451, 838.5010918503481, 819.5574389829485, 824.118193532923, 824.8680211166214, 826.2481142160635, 829.8257365953157, 501.4605162152194, 503.5769953239297, 505.55511150187965, 608.3156448994881, 610.6122612141278, 13197.142185757895, 14743.557693269218, 15262.542123736306, 15353.309101090477, 16051.919740401223, 14472.85527144736, 14782.48261310849, 15366.846331536653, 15465.149416782073, 15634.45279415215, 11584.594539191172, 11603.361815100166, 11714.180007399485, 11848.644540663709, 11919.821202681967, 3839.3856982882603, 3848.326542855017, 3871.0, 3886.222755448893, 3957.28768821612, 83228.58385708093, 83923.0, 84529.99999999939, 85010.99999999937, 85906.57046714726, 10351.792964140675, 10428.165746740242, 11582.189246752814, 11606.24559403636, 12351.38243087842, 23264.4183895404, 23297.30108096726, 23336.883315583655, 23409.531809364056, 23457.7654223459, 8069.475484093515, 8709.346798990102, 8967.596458159398, 8987.41581797181, 8996.0, 4708.929366059512, 4824.903501930012, 4970.453250142481, 5000.174971129795, 5094.5669618082875, 3568.91077723059, 3669.94495082574, 3704.388775852008, 3706.221693444353, 3724.640506215266, 574.2362657665295, 580.1095318685797, 584.231735268121, 593.5340757505337, 593.9109133629904, 575.9862641750549, 632.6836581709146, 641.2369280556123, 702.7575486457266, 707.8195060259601, 8665.696700615448, 9232.538373081454, 9235.538223088819, 9396.201322887495, 9539.904600953902, 656.7504348347597, 667.7462564225564, 672.862063277027, 673.7641825361085, 678.3318431345122, 4295.0, 4875.366202393737, 4938.283948827472, 5081.907389911113, 5238.842834714965, 128601.0, 130043.0, 130813.34593326972, 131154.0, 135026.324868377, 105655.47172264243, 107828.0, 108730.0, 111605.0, 111939.0, 95990.0, 96479.51760241154, 96862.51568742111, 99238.54188019584, 102282.0, 9276.25789936817, 9688.722538001266, 9760.105159382167, 9785.525452702368, 9813.11681948628, 46760.7661961688, 56198.0, 56259.43740562705, 56754.716226418604, 57822.13266800917, 65595.0, 72519.63740181265, 73453.0, 74754.62622686852, 78215.60892195502, 13188.80216796768, 13244.337783111, 13266.86733132695, 13519.932400337935, 13608.659783505096, 13908.860911390757, 14124.43502259898, 14141.292935352985, 14267.857321427067, 14327.35526901271, 12851.485940562647, 13008.674783130118, 13014.4143513544, 13097.869021309665, 14083.436662533384, 11147.554097835995, 11317.830232546354, 11341.432928353384, 11542.94228528852, 12486.37568121572, 11488.195826292414, 11588.942055290006, 11978.46096925658, 12627.93686031564, 12673.556425525063, 9601.279904007368, 10167.237457190888, 10365.63720269787, 10581.748465498122, 10832.67501974942, 9322.207612353026, 10675.89324106749, 10733.248672592843, 10735.838962415726, 11031.724206894893], "value": 7498.154610946619, "unit": "score"}], "name": "dromaeo_css", "value": 7157.460979514948, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 111.0, 112.0, 109.0, 110.0, 110.0, 112.0, 110.0, 110.0, 112.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 121.0, 123.0, 180.0, 119.0, 120.0, 118.0, 117.0, 148.0, 122.0], "value": 132.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 161.0, 160.0, 162.0, 159.0, 161.0, 160.0, 161.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 78.0, 106.0, 76.0, 77.0, 76.0, 77.0, 98.0, 77.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 124.0, 83.0, 82.0, 85.0, 103.0, 82.0, 82.0, 113.0], "value": 91.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 148.0, 147.0, 147.0, 147.0, 146.0, 146.0, 145.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 50.0, 58.0, 52.0, 51.0, 52.0, 51.0, 52.0, 52.0], "value": 52.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 61.0, 61.0, 60.0, 61.0, 61.0, 61.0, 61.0, 61.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 84.0, 79.0, 78.0, 78.0, 79.0, 77.0, 77.0, 77.0], "value": 78.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 132.0, 133.0, 124.0, 123.0, 132.0, 124.0, 132.0, 172.0, 142.0], "value": 133.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 168.0, 163.0, 166.0, 164.0, 162.0, 162.0, 162.0, 160.0], "value": 163.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 66.0], "value": 64.7, "unit": "score"}], "name": "kraken", "value": 1489.5000000000002, "alertThreshold": 2.0}]} 12:37:02 INFO - Return code: 0 12:37:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:37:02 INFO - # TBPL SUCCESS # 12:37:02 INFO - Running post-action listener: _resource_record_post_action 12:37:02 INFO - [mozharness: 2016-09-21 19:37:02.555241Z] Finished run-tests step (success) 12:37:02 INFO - Running post-run listener: _resource_record_post_run 12:37:02 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392826880; Read time: 8; Write time: 356496 12:37:02 INFO - TinderboxPrint: CPU usage
13.0% 12:37:02 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 12:37:02 INFO - TinderboxPrint: I/O write bytes / time
392,826,880 / 356,496 12:37:02 INFO - TinderboxPrint: CPU idle
8,296.5 (86.9%) 12:37:02 INFO - TinderboxPrint: CPU user
1,195.9 (12.5%) 12:37:02 INFO - TinderboxPrint: Swap in / out
0 / 0 12:37:02 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103632896; Read time: 0; Write time: 110048 12:37:02 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 288669696; Read time: 0; Write time: 246420 12:37:03 INFO - Running post-run listener: _upload_blobber_files 12:37:03 INFO - Blob upload gear active. 12:37:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:37:03 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 12:37:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:37:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:37:03 INFO - (blobuploader) - INFO - Open directory for files ... 12:37:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:37:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:37:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:37:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:37:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:37:04 INFO - (blobuploader) - INFO - Done attempting. 12:37:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:37:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:37:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:37:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:37:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:37:06 INFO - (blobuploader) - INFO - Done attempting. 12:37:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:37:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:37:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:37:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:37:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:37:10 INFO - (blobuploader) - INFO - Done attempting. 12:37:10 INFO - (blobuploader) - INFO - Iteration through files over. 12:37:10 INFO - Return code: 0 12:37:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:37:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:37:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5fb7fed22ccb9da18c5b14f70eac7af8c16fc3367d74c5569b90733e86078254ef522a32060493f0ea373db95a1f92682f950a4d784f9b913ff5faea110cefd2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c91e78c75ccb790065dee80bc8cc5f3d1ecb4a98453f6be1b563d70817fb6ebabef9f91fdeed611a745f6328b2f435b3157fcfa5ce4fe058db4c3b0c88f124c0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f9c615fb5db66b4d69288fa2eed1ae806ce4eee661ced3665caf56eb18a12bbcdc49431db7080e4ee8afecc78a62ccbe1c4714e8a15c1661e9b2ba09b29e827c"} 12:37:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:37:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:37:10 INFO - Contents: 12:37:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5fb7fed22ccb9da18c5b14f70eac7af8c16fc3367d74c5569b90733e86078254ef522a32060493f0ea373db95a1f92682f950a4d784f9b913ff5faea110cefd2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c91e78c75ccb790065dee80bc8cc5f3d1ecb4a98453f6be1b563d70817fb6ebabef9f91fdeed611a745f6328b2f435b3157fcfa5ce4fe058db4c3b0c88f124c0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f9c615fb5db66b4d69288fa2eed1ae806ce4eee661ced3665caf56eb18a12bbcdc49431db7080e4ee8afecc78a62ccbe1c4714e8a15c1661e9b2ba09b29e827c"} 12:37:10 INFO - Running post-run listener: copy_logs_to_upload_dir 12:37:10 INFO - Copying logs to upload dir... 12:37:10 INFO - mkdir: /builds/slave/test/build/upload/logs 12:37:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.380278 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-09-21 12:37:10.734642) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-21 12:37:10.738722) ========= 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=652eb03db935cfc1c15ebda0000001ad-1474483357.192167-1059196066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5fb7fed22ccb9da18c5b14f70eac7af8c16fc3367d74c5569b90733e86078254ef522a32060493f0ea373db95a1f92682f950a4d784f9b913ff5faea110cefd2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c91e78c75ccb790065dee80bc8cc5f3d1ecb4a98453f6be1b563d70817fb6ebabef9f91fdeed611a745f6328b2f435b3157fcfa5ce4fe058db4c3b0c88f124c0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f9c615fb5db66b4d69288fa2eed1ae806ce4eee661ced3665caf56eb18a12bbcdc49431db7080e4ee8afecc78a62ccbe1c4714e8a15c1661e9b2ba09b29e827c"} build_url:https://queue.taskcluster.net/v1/task/N6LK0xR1TcSwN_K8AVA7IA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011438 build_url: 'https://queue.taskcluster.net/v1/task/N6LK0xR1TcSwN_K8AVA7IA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5fb7fed22ccb9da18c5b14f70eac7af8c16fc3367d74c5569b90733e86078254ef522a32060493f0ea373db95a1f92682f950a4d784f9b913ff5faea110cefd2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c91e78c75ccb790065dee80bc8cc5f3d1ecb4a98453f6be1b563d70817fb6ebabef9f91fdeed611a745f6328b2f435b3157fcfa5ce4fe058db4c3b0c88f124c0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f9c615fb5db66b4d69288fa2eed1ae806ce4eee661ced3665caf56eb18a12bbcdc49431db7080e4ee8afecc78a62ccbe1c4714e8a15c1661e9b2ba09b29e827c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-21 12:37:10.765660) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 12:37:10.766103) ========= 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=652eb03db935cfc1c15ebda0000001ad-1474483357.192167-1059196066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004455 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 12:37:10.849790) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-21 12:37:10.850223) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-21 12:37:10.850614) ========= ========= Total master_lag: 1.71 =========