builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-015 starttime: 1474507353.86 results: success (0) buildid: 20160921153000 builduid: 38d70451cdc84c52b462ba29f3834586 revision: 94d6bc5adab3d63533f5c5c33df14c7d3f763859 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-21 18:22:33.865431) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-21 18:22:33.866104) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-21 18:22:33.866453) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-21 18:22:33.881941) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 18:22:33.882304) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1474505741.291732-1031377363 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-21 18:22:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-09-21 18:22:33 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.137367 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 18:22:34.046345) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 18:22:34.046678) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1474505741.291732-1031377363 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017820 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 18:22:34.106239) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-21 18:22:34.106865) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 94d6bc5adab3d63533f5c5c33df14c7d3f763859 --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 94d6bc5adab3d63533f5c5c33df14c7d3f763859 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1474505741.291732-1031377363 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-21 18:22:34,128 truncating revision to first 12 chars 2016-09-21 18:22:34,128 Setting DEBUG logging. 2016-09-21 18:22:34,128 attempt 1/10 2016-09-21 18:22:34,128 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/94d6bc5adab3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-21 18:22:35,363 unpacking tar archive at: fx-team-94d6bc5adab3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.553812 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-21 18:22:35.676236) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-21 18:22:35.676576) ========= script_repo_revision: 94d6bc5adab3d63533f5c5c33df14c7d3f763859 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-21 18:22:35.677053) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-21 18:22:35.677364) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-21 18:22:35.688187) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-09-21 18:22:35.688645) ========= /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=20e666a3d4cfbb71505a330e000001b4-1474505741.291732-1031377363 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:22:35 INFO - MultiFileLogger online at 20160921 18:22:35 in /builds/slave/test 18:22:35 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 18:22:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:22:35 INFO - {'append_to_log': False, 18:22:35 INFO - 'base_work_dir': '/builds/slave/test', 18:22:35 INFO - 'blob_upload_branch': 'Fx-Team', 18:22:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:22:35 INFO - 'branch': 'Fx-Team', 18:22:35 INFO - 'buildbot_json_path': 'buildprops.json', 18:22:35 INFO - 'config_files': ('talos/linux_config.py',), 18:22:35 INFO - 'default_actions': ('clobber', 18:22:35 INFO - 'read-buildbot-config', 18:22:35 INFO - 'download-and-extract', 18:22:35 INFO - 'populate-webroot', 18:22:35 INFO - 'create-virtualenv', 18:22:35 INFO - 'install', 18:22:35 INFO - 'run-tests'), 18:22:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:22:35 INFO - 'download_minidump_stackwalk': True, 18:22:35 INFO - 'download_symbols': 'ondemand', 18:22:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:22:35 INFO - 'tooltool.py': '/tools/tooltool.py', 18:22:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:22:35 INFO - '/tools/misc-python/virtualenv.py')}, 18:22:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:22:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:22:35 INFO - 'installer_path': 'installer.exe', 18:22:35 INFO - 'log_level': 'info', 18:22:35 INFO - 'log_name': 'talos', 18:22:35 INFO - 'log_to_console': True, 18:22:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:22:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:22:35 INFO - 'opt_config_files': (), 18:22:35 INFO - 'pip_index': False, 18:22:35 INFO - 'sps_profile': False, 18:22:35 INFO - 'sps_profile_interval': 0, 18:22:35 INFO - 'suite': 'dromaeojs', 18:22:35 INFO - 'system_bits': '32', 18:22:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:22:35 INFO - 'title': 'talos-linux64-ix-015', 18:22:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:22:35 INFO - 'use_talos_json': True, 18:22:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:22:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:22:35 INFO - 'work_dir': 'build'} 18:22:35 INFO - [mozharness: 2016-09-22 01:22:35.810503Z] Running clobber step. 18:22:35 INFO - Running pre-action listener: _resource_record_pre_action 18:22:35 INFO - Running main action method: clobber 18:22:35 INFO - rmtree: /builds/slave/test/build 18:22:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:22:36 INFO - Running post-action listener: _resource_record_post_action 18:22:36 INFO - [mozharness: 2016-09-22 01:22:36.766725Z] Finished clobber step (success) 18:22:36 INFO - [mozharness: 2016-09-22 01:22:36.766825Z] Running read-buildbot-config step. 18:22:36 INFO - Running pre-action listener: _resource_record_pre_action 18:22:36 INFO - Running main action method: read_buildbot_config 18:22:36 INFO - Using buildbot properties: 18:22:36 INFO - { 18:22:36 INFO - "project": "", 18:22:36 INFO - "product": "firefox", 18:22:36 INFO - "script_repo_revision": "production", 18:22:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 18:22:36 INFO - "repository": "", 18:22:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 18:22:36 INFO - "buildid": "20160921153000", 18:22:36 INFO - "pgo_build": "True", 18:22:36 INFO - "basedir": "/builds/slave/test", 18:22:36 INFO - "buildnumber": 467, 18:22:36 INFO - "slavename": "talos-linux64-ix-015", 18:22:36 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:22:36 INFO - "platform": "ubuntu64_hw", 18:22:36 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 18:22:36 INFO - "branch": "fx-team", 18:22:36 INFO - "repo_path": "integration/fx-team", 18:22:36 INFO - "revision": "94d6bc5adab3d63533f5c5c33df14c7d3f763859", 18:22:36 INFO - "stage_platform": "linux64-pgo", 18:22:36 INFO - "builduid": "38d70451cdc84c52b462ba29f3834586", 18:22:36 INFO - "slavebuilddir": "test" 18:22:36 INFO - } 18:22:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/AuVVSrCjQ8q-EFfV2bbuHg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 18:22:36 INFO - Running post-action listener: _resource_record_post_action 18:22:36 INFO - [mozharness: 2016-09-22 01:22:36.769271Z] Finished read-buildbot-config step (success) 18:22:36 INFO - [mozharness: 2016-09-22 01:22:36.769377Z] Running download-and-extract step. 18:22:36 INFO - Running pre-action listener: _resource_record_pre_action 18:22:36 INFO - Running main action method: download_and_extract 18:22:36 INFO - mkdir: /builds/slave/test/build/tests 18:22:36 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')]} 18:22:36 INFO - trying https://queue.taskcluster.net/v1/task/AuVVSrCjQ8q-EFfV2bbuHg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:22:36 INFO - Downloading https://queue.taskcluster.net/v1/task/AuVVSrCjQ8q-EFfV2bbuHg/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 18:22:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AuVVSrCjQ8q-EFfV2bbuHg/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 18:22:37 INFO - Downloaded 1361 bytes. 18:22:37 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:22:37 INFO - Using the following test package requirements: 18:22:37 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:22:37 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:22:37 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:22:37 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:22:37 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:22:37 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:22:37 INFO - u'jsshell-linux-x86_64.zip'], 18:22:37 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:22:37 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:22:37 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:22:37 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:22:37 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:22:37 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:22:37 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:22:37 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:22:37 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:22:37 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:22:37 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:22:37 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:22:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AuVVSrCjQ8q-EFfV2bbuHg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:22:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AuVVSrCjQ8q-EFfV2bbuHg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:22:37 INFO - Fetch https://queue.taskcluster.net/v1/task/AuVVSrCjQ8q-EFfV2bbuHg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:22:37 INFO - Expected file size: 21941737 18:22:42 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 18:22:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AuVVSrCjQ8q-EFfV2bbuHg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:22:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AuVVSrCjQ8q-EFfV2bbuHg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:22:42 INFO - Fetch https://queue.taskcluster.net/v1/task/AuVVSrCjQ8q-EFfV2bbuHg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:22:42 INFO - Expected file size: 21941737 18:22:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AuVVSrCjQ8q-EFfV2bbuHg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 18:22:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AuVVSrCjQ8q-EFfV2bbuHg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:22:47 INFO - Fetch https://queue.taskcluster.net/v1/task/AuVVSrCjQ8q-EFfV2bbuHg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 18:22:48 INFO - Expected file size: 14414059 18:22: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')]} 18:22:48 INFO - trying https://queue.taskcluster.net/v1/task/AuVVSrCjQ8q-EFfV2bbuHg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:22:48 INFO - Downloading https://queue.taskcluster.net/v1/task/AuVVSrCjQ8q-EFfV2bbuHg/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 18:22:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AuVVSrCjQ8q-EFfV2bbuHg/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 18:22:50 INFO - Downloaded 59537751 bytes. 18:22:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AuVVSrCjQ8q-EFfV2bbuHg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:22:50 INFO - mkdir: /builds/slave/test/properties 18:22:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:22:50 INFO - Writing to file /builds/slave/test/properties/build_url 18:22:50 INFO - Contents: 18:22:50 INFO - build_url:https://queue.taskcluster.net/v1/task/AuVVSrCjQ8q-EFfV2bbuHg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:22:51 INFO - Running post-action listener: _resource_record_post_action 18:22:51 INFO - Running post-action listener: set_extra_try_arguments 18:22:51 INFO - [mozharness: 2016-09-22 01:22:51.017679Z] Finished download-and-extract step (success) 18:22:51 INFO - [mozharness: 2016-09-22 01:22:51.017906Z] Running populate-webroot step. 18:22:51 INFO - Running pre-action listener: _resource_record_pre_action 18:22:51 INFO - Running main action method: populate_webroot 18:22:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:22:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:22:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:22:51 INFO - '--tppagecycles', 18:22:51 INFO - '7'], 18:22:51 INFO - 'tests': ['tsvgm']}}, 18:22:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:22:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:22:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:22:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:22:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:22:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:22:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:22:51 INFO - 'talos_options': ['--disable-e10s'], 18:22:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:22:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:22:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:22:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:22:51 INFO - 'talos_options': ['--disable-e10s'], 18:22:51 INFO - 'tests': ['damp', 'tps']}, 18:22:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:22:51 INFO - 'tests': ['damp', 'tps']}, 18:22:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:22:51 INFO - 'tests': ['dromaeo_dom']}, 18:22:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:22:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:22:51 INFO - 'tests': ['basic_compositor_video']}, 18:22:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:22:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:22:51 INFO - 'tests': ['a11yr', 18:22:51 INFO - 'ts_paint', 18:22:51 INFO - 'tpaint', 18:22:51 INFO - 'sessionrestore', 18:22:51 INFO - 'sessionrestore_no_auto_restore', 18:22:51 INFO - 'tabpaint']}, 18:22:51 INFO - 'other-e10s': {'tests': ['a11yr', 18:22:51 INFO - 'ts_paint', 18:22:51 INFO - 'tpaint', 18:22:51 INFO - 'sessionrestore', 18:22:51 INFO - 'sessionrestore_no_auto_restore', 18:22:51 INFO - 'tabpaint']}, 18:22:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:22:51 INFO - 'ts_paint', 18:22:51 INFO - 'tpaint', 18:22:51 INFO - 'sessionrestore', 18:22:51 INFO - 'sessionrestore_no_auto_restore', 18:22:51 INFO - 'tabpaint']}, 18:22:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:22:51 INFO - 'ts_paint', 18:22:51 INFO - 'tpaint', 18:22:51 INFO - 'sessionrestore', 18:22:51 INFO - 'sessionrestore_no_auto_restore', 18:22:51 INFO - 'tabpaint']}, 18:22:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:22:51 INFO - 'tests': ['a11yr', 18:22:51 INFO - 'ts_paint', 18:22:51 INFO - 'tpaint', 18:22:51 INFO - 'sessionrestore', 18:22:51 INFO - 'sessionrestore_no_auto_restore', 18:22:51 INFO - 'tabpaint']}, 18:22:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:22:51 INFO - 'tests': ['a11yr', 18:22:51 INFO - 'ts_paint', 18:22:51 INFO - 'tpaint', 18:22:51 INFO - 'sessionrestore', 18:22:51 INFO - 'sessionrestore_no_auto_restore', 18:22:51 INFO - 'tabpaint']}, 18:22:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:22:51 INFO - 'tests': ['tsvgx', 18:22:51 INFO - 'tsvgr_opacity', 18:22:51 INFO - 'tart', 18:22:51 INFO - 'tscrollx', 18:22:51 INFO - 'cart']}, 18:22:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:22:51 INFO - 'tsvgr_opacity', 18:22:51 INFO - 'tart', 18:22:51 INFO - 'tscrollx', 18:22:51 INFO - 'cart']}, 18:22:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:22:51 INFO - 'talos_options': ['--disable-e10s'], 18:22:51 INFO - 'tests': ['tp5o']}, 18:22:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:22:51 INFO - 'tests': ['tp5o']}, 18:22:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:22:51 INFO - 'talos_options': ['--disable-e10s', 18:22:51 INFO - '--xperf_path', 18:22:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:22:51 INFO - 'tests': ['tp5n']}, 18:22:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:22:51 INFO - 'talos_options': ['--xperf_path', 18:22:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:22:51 INFO - 'tests': ['tp5n']}}, 18:22:51 INFO - 'talos.zip': {'path': '', 18:22:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:22:51 INFO - Running post-action listener: _resource_record_post_action 18:22:51 INFO - [mozharness: 2016-09-22 01:22:51.036167Z] Finished populate-webroot step (success) 18:22:51 INFO - [mozharness: 2016-09-22 01:22:51.036257Z] Running create-virtualenv step. 18:22:51 INFO - Running pre-action listener: _resource_record_pre_action 18:22:51 INFO - Running main action method: create_virtualenv 18:22:51 INFO - Creating virtualenv /builds/slave/test/build/venv 18:22:51 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 18:22:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:22:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:22:51 INFO - Using real prefix '/usr' 18:22:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:22:51 INFO - Installing distribute.............................................................................................................................................................................................done. 18:22:53 INFO - Installing pip.................done. 18:22:53 INFO - Return code: 0 18:22:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:22:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:53 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 0x7f3f32004f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b37b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2242790>, '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 0x2243690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2243b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1474505741.291732-1031377363', '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 18:22:53 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 18:22:53 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 18:22:53 INFO - Using env: {'DISPLAY': ':0', 18:22:53 INFO - 'HOME': '/home/cltbld', 18:22:53 INFO - 'LANG': 'en_US.UTF-8', 18:22:53 INFO - 'LANGUAGE': 'en_US:en', 18:22:53 INFO - 'LOGNAME': 'cltbld', 18:22:53 INFO - 'MAIL': '/var/mail/cltbld', 18:22:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:53 INFO - 'MOZ_NO_REMOTE': '1', 18:22:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:53 INFO - 'NO_EM_RESTART': '1', 18:22:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:53 INFO - 'PWD': '/builds/slave/test', 18:22:53 INFO - 'SHELL': '/bin/bash', 18:22:53 INFO - 'SHLVL': '1', 18:22:53 INFO - 'TERM': 'linux', 18:22:53 INFO - 'TMOUT': '86400', 18:22:53 INFO - 'USER': 'cltbld', 18:22:53 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1474505741.291732-1031377363', 18:22:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:53 INFO - '_': '/tools/buildbot/bin/python'} 18:22:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:53 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 18:22:53 INFO - Cleaning up... 18:22:53 INFO - Return code: 0 18:22:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:22:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:53 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 0x7f3f32004f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b37b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2242790>, '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 0x2243690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2243b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1474505741.291732-1031377363', '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 18:22:53 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 18:22:53 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 18:22:53 INFO - Using env: {'DISPLAY': ':0', 18:22:53 INFO - 'HOME': '/home/cltbld', 18:22:53 INFO - 'LANG': 'en_US.UTF-8', 18:22:53 INFO - 'LANGUAGE': 'en_US:en', 18:22:53 INFO - 'LOGNAME': 'cltbld', 18:22:53 INFO - 'MAIL': '/var/mail/cltbld', 18:22:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:53 INFO - 'MOZ_NO_REMOTE': '1', 18:22:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:53 INFO - 'NO_EM_RESTART': '1', 18:22:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:53 INFO - 'PWD': '/builds/slave/test', 18:22:53 INFO - 'SHELL': '/bin/bash', 18:22:53 INFO - 'SHLVL': '1', 18:22:53 INFO - 'TERM': 'linux', 18:22:53 INFO - 'TMOUT': '86400', 18:22:53 INFO - 'USER': 'cltbld', 18:22:53 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1474505741.291732-1031377363', 18:22:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:53 INFO - '_': '/tools/buildbot/bin/python'} 18:22:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:54 INFO - Downloading/unpacking psutil>=3.1.1 18:22: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 18:22: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 18:22: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 18:22: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 18:22: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 18:22: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 18:22:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:22:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:22:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:22:56 INFO - Installing collected packages: psutil 18:22:56 INFO - Running setup.py install for psutil 18:22:56 INFO - building 'psutil._psutil_linux' extension 18:22:56 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 18:22:56 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 18:22:56 INFO - building 'psutil._psutil_posix' extension 18:22:56 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 18:22:56 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 18:22:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:22:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:22:56 INFO - Successfully installed psutil 18:22:56 INFO - Cleaning up... 18:22:56 INFO - Return code: 0 18:22:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:22:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3f32004f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b37b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2242790>, '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 0x2243690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2243b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1474505741.291732-1031377363', '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 18:22:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:22:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:22:56 INFO - Using env: {'DISPLAY': ':0', 18:22:56 INFO - 'HOME': '/home/cltbld', 18:22:56 INFO - 'LANG': 'en_US.UTF-8', 18:22:56 INFO - 'LANGUAGE': 'en_US:en', 18:22:56 INFO - 'LOGNAME': 'cltbld', 18:22:56 INFO - 'MAIL': '/var/mail/cltbld', 18:22:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:56 INFO - 'MOZ_NO_REMOTE': '1', 18:22:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:56 INFO - 'NO_EM_RESTART': '1', 18:22:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:56 INFO - 'PWD': '/builds/slave/test', 18:22:56 INFO - 'SHELL': '/bin/bash', 18:22:56 INFO - 'SHLVL': '1', 18:22:56 INFO - 'TERM': 'linux', 18:22:56 INFO - 'TMOUT': '86400', 18:22:56 INFO - 'USER': 'cltbld', 18:22:56 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1474505741.291732-1031377363', 18:22:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:56 INFO - '_': '/tools/buildbot/bin/python'} 18:22:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:22:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:22:58 INFO - Installing collected packages: mozsystemmonitor 18:22:58 INFO - Running setup.py install for mozsystemmonitor 18:22:58 INFO - Successfully installed mozsystemmonitor 18:22:58 INFO - Cleaning up... 18:22:58 INFO - Return code: 0 18:22:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:22: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')]} 18:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22: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')]} 18:22:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:58 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 0x7f3f32004f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b37b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2242790>, '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 0x2243690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2243b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1474505741.291732-1031377363', '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 18:22:58 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 18:22:58 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 18:22:58 INFO - Using env: {'DISPLAY': ':0', 18:22:58 INFO - 'HOME': '/home/cltbld', 18:22:58 INFO - 'LANG': 'en_US.UTF-8', 18:22:58 INFO - 'LANGUAGE': 'en_US:en', 18:22:58 INFO - 'LOGNAME': 'cltbld', 18:22:58 INFO - 'MAIL': '/var/mail/cltbld', 18:22:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:58 INFO - 'MOZ_NO_REMOTE': '1', 18:22:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:58 INFO - 'NO_EM_RESTART': '1', 18:22:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:58 INFO - 'PWD': '/builds/slave/test', 18:22:58 INFO - 'SHELL': '/bin/bash', 18:22:58 INFO - 'SHLVL': '1', 18:22:58 INFO - 'TERM': 'linux', 18:22:58 INFO - 'TMOUT': '86400', 18:22:58 INFO - 'USER': 'cltbld', 18:22:58 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1474505741.291732-1031377363', 18:22:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:58 INFO - '_': '/tools/buildbot/bin/python'} 18:22:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:59 INFO - Downloading/unpacking jsonschema==2.5.1 18:22:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:23:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:23:00 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 18:23:00 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 18:23:00 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 18:23:00 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 18:23:00 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 18:23:00 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 18:23:01 INFO - Downloading functools32-3.2.3-2.tar.gz 18:23:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:23:01 INFO - warning: no files found matching '*.txt' 18:23:01 INFO - no previously-included directories found matching 'build' 18:23:01 INFO - no previously-included directories found matching 'dist' 18:23:01 INFO - no previously-included directories found matching '.git*' 18:23:01 INFO - Installing collected packages: jsonschema, functools32 18:23:01 INFO - Running setup.py install for functools32 18:23:01 INFO - warning: no files found matching '*.txt' 18:23:01 INFO - no previously-included directories found matching 'build' 18:23:01 INFO - no previously-included directories found matching 'dist' 18:23:01 INFO - no previously-included directories found matching '.git*' 18:23:01 INFO - Successfully installed jsonschema functools32 18:23:01 INFO - Cleaning up... 18:23:01 INFO - Return code: 0 18:23:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:23:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:23:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3f32004f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b37b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2242790>, '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 0x2243690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2243b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1474505741.291732-1031377363', '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 18:23:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:23:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:23:01 INFO - Using env: {'DISPLAY': ':0', 18:23:01 INFO - 'HOME': '/home/cltbld', 18:23:01 INFO - 'LANG': 'en_US.UTF-8', 18:23:01 INFO - 'LANGUAGE': 'en_US:en', 18:23:01 INFO - 'LOGNAME': 'cltbld', 18:23:01 INFO - 'MAIL': '/var/mail/cltbld', 18:23:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:01 INFO - 'MOZ_NO_REMOTE': '1', 18:23:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:23:01 INFO - 'NO_EM_RESTART': '1', 18:23:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:23:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:01 INFO - 'PWD': '/builds/slave/test', 18:23:01 INFO - 'SHELL': '/bin/bash', 18:23:01 INFO - 'SHLVL': '1', 18:23:01 INFO - 'TERM': 'linux', 18:23:01 INFO - 'TMOUT': '86400', 18:23:01 INFO - 'USER': 'cltbld', 18:23:01 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1474505741.291732-1031377363', 18:23:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:01 INFO - '_': '/tools/buildbot/bin/python'} 18:23:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:23:01 INFO - Cleaning up... 18:23:01 INFO - Return code: 0 18:23:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:23:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:23:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3f32004f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b37b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2242790>, '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 0x2243690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2243b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1474505741.291732-1031377363', '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 18:23:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:23:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:23:01 INFO - Using env: {'DISPLAY': ':0', 18:23:01 INFO - 'HOME': '/home/cltbld', 18:23:01 INFO - 'LANG': 'en_US.UTF-8', 18:23:01 INFO - 'LANGUAGE': 'en_US:en', 18:23:01 INFO - 'LOGNAME': 'cltbld', 18:23:01 INFO - 'MAIL': '/var/mail/cltbld', 18:23:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:01 INFO - 'MOZ_NO_REMOTE': '1', 18:23:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:23:01 INFO - 'NO_EM_RESTART': '1', 18:23:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:23:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:01 INFO - 'PWD': '/builds/slave/test', 18:23:01 INFO - 'SHELL': '/bin/bash', 18:23:01 INFO - 'SHLVL': '1', 18:23:01 INFO - 'TERM': 'linux', 18:23:01 INFO - 'TMOUT': '86400', 18:23:01 INFO - 'USER': 'cltbld', 18:23:01 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1474505741.291732-1031377363', 18:23:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:01 INFO - '_': '/tools/buildbot/bin/python'} 18:23:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:01 INFO - Downloading/unpacking blobuploader==1.2.4 18:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:03 INFO - Downloading blobuploader-1.2.4.tar.gz 18:23:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:23:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:23: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 18:23: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 18:23: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 18:23: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 18:23: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 18:23: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 18:23:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:23:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:04 INFO - Downloading docopt-0.6.1.tar.gz 18:23:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:23:04 INFO - Installing collected packages: blobuploader, requests, docopt 18:23:04 INFO - Running setup.py install for blobuploader 18:23:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:23:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:23:04 INFO - Running setup.py install for requests 18:23:05 INFO - Running setup.py install for docopt 18:23:05 INFO - Successfully installed blobuploader requests docopt 18:23:05 INFO - Cleaning up... 18:23:05 INFO - Return code: 0 18:23:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:23: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')]} 18:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23: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')]} 18:23:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:05 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 0x7f3f32004f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b37b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2242790>, '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 0x2243690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2243b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1474505741.291732-1031377363', '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 18:23:05 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 18:23:05 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 18:23:05 INFO - Using env: {'DISPLAY': ':0', 18:23:05 INFO - 'HOME': '/home/cltbld', 18:23:05 INFO - 'LANG': 'en_US.UTF-8', 18:23:05 INFO - 'LANGUAGE': 'en_US:en', 18:23:05 INFO - 'LOGNAME': 'cltbld', 18:23:05 INFO - 'MAIL': '/var/mail/cltbld', 18:23:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:05 INFO - 'MOZ_NO_REMOTE': '1', 18:23:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:23:05 INFO - 'NO_EM_RESTART': '1', 18:23:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:23:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:05 INFO - 'PWD': '/builds/slave/test', 18:23:05 INFO - 'SHELL': '/bin/bash', 18:23:05 INFO - 'SHLVL': '1', 18:23:05 INFO - 'TERM': 'linux', 18:23:05 INFO - 'TMOUT': '86400', 18:23:05 INFO - 'USER': 'cltbld', 18:23:05 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1474505741.291732-1031377363', 18:23:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:05 INFO - '_': '/tools/buildbot/bin/python'} 18:23:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:23:05 INFO - Running setup.py (path:/tmp/pip-zXIbRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:23:05 INFO - Running setup.py (path:/tmp/pip-THIhzs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:23:05 INFO - Running setup.py (path:/tmp/pip-LB6ihx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:23:05 INFO - Running setup.py (path:/tmp/pip-4QudBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:23:05 INFO - Running setup.py (path:/tmp/pip-Z0BsR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:23:05 INFO - Running setup.py (path:/tmp/pip-D4jGz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:23:05 INFO - Running setup.py (path:/tmp/pip-aZLci0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:23:05 INFO - Running setup.py (path:/tmp/pip-6jXKr3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:23:05 INFO - Running setup.py (path:/tmp/pip-jiU2w8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:23:06 INFO - Running setup.py (path:/tmp/pip-dwggx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:23:06 INFO - Running setup.py (path:/tmp/pip-B1iC5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:23:06 INFO - Running setup.py (path:/tmp/pip-OWob0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:23:06 INFO - Running setup.py (path:/tmp/pip-BoIQqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:23:06 INFO - Running setup.py (path:/tmp/pip-BKU6n_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:23:06 INFO - Running setup.py (path:/tmp/pip-GCPjQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:23:06 INFO - Running setup.py (path:/tmp/pip-gljDAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:23:06 INFO - Running setup.py (path:/tmp/pip-OMRN03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:23:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:23:06 INFO - Running setup.py install for manifestparser 18:23:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:23:06 INFO - Running setup.py install for mozcrash 18:23:06 INFO - Running setup.py install for mozdebug 18:23:06 INFO - Running setup.py install for mozdevice 18:23:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:23:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:23:07 INFO - Running setup.py install for mozfile 18:23:07 INFO - Running setup.py install for mozhttpd 18:23:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:23:07 INFO - Running setup.py install for mozinfo 18:23:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:23:07 INFO - Running setup.py install for mozInstall 18:23:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:23:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:23:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:23:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:23:07 INFO - Running setup.py install for mozleak 18:23:07 INFO - Running setup.py install for mozlog 18:23:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:23:07 INFO - Running setup.py install for moznetwork 18:23:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:23:07 INFO - Running setup.py install for mozprocess 18:23:07 INFO - Running setup.py install for mozprofile 18:23:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:23:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:23:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:23:07 INFO - Running setup.py install for mozrunner 18:23:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:23:08 INFO - Running setup.py install for mozscreenshot 18:23:08 INFO - Running setup.py install for moztest 18:23:08 INFO - Running setup.py install for mozversion 18:23:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:23:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:23:08 INFO - Cleaning up... 18:23:08 INFO - Return code: 0 18:23:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:23:08 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')]} 18:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:08 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')]} 18:23:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:08 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 0x7f3f32004f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b37b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2242790>, '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 0x2243690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2243b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1474505741.291732-1031377363', '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 18:23:08 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 18:23:08 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 18:23:08 INFO - Using env: {'DISPLAY': ':0', 18:23:08 INFO - 'HOME': '/home/cltbld', 18:23:08 INFO - 'LANG': 'en_US.UTF-8', 18:23:08 INFO - 'LANGUAGE': 'en_US:en', 18:23:08 INFO - 'LOGNAME': 'cltbld', 18:23:08 INFO - 'MAIL': '/var/mail/cltbld', 18:23:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:08 INFO - 'MOZ_NO_REMOTE': '1', 18:23:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:23:08 INFO - 'NO_EM_RESTART': '1', 18:23:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:23:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:08 INFO - 'PWD': '/builds/slave/test', 18:23:08 INFO - 'SHELL': '/bin/bash', 18:23:08 INFO - 'SHLVL': '1', 18:23:08 INFO - 'TERM': 'linux', 18:23:08 INFO - 'TMOUT': '86400', 18:23:08 INFO - 'USER': 'cltbld', 18:23:08 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1474505741.291732-1031377363', 18:23:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:08 INFO - '_': '/tools/buildbot/bin/python'} 18:23:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:23:08 INFO - Running setup.py (path:/tmp/pip-IMVBSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:23:08 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)) 18:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:23:08 INFO - Running setup.py (path:/tmp/pip-GpgolP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:23:08 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)) 18:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:23:08 INFO - Running setup.py (path:/tmp/pip-hUOPbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:23:08 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)) 18:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:23:08 INFO - Running setup.py (path:/tmp/pip-pEihIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:23:08 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)) 18:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:23:08 INFO - Running setup.py (path:/tmp/pip-wzwEDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:23:08 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)) 18:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:23:09 INFO - Running setup.py (path:/tmp/pip-0stkH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:23:09 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)) 18:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:23:09 INFO - Running setup.py (path:/tmp/pip-sMs1H9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:23:09 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)) 18:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:23:09 INFO - Running setup.py (path:/tmp/pip-CfTLvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:23:09 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)) 18:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:23:09 INFO - Running setup.py (path:/tmp/pip-kJikKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:23:09 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)) 18:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:23:09 INFO - Running setup.py (path:/tmp/pip-3ikoZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:23:09 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)) 18:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:23:09 INFO - Running setup.py (path:/tmp/pip-1IPw61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:23:09 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)) 18:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:23:09 INFO - Running setup.py (path:/tmp/pip-7UQUKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:23:09 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)) 18:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:23:09 INFO - Running setup.py (path:/tmp/pip-qYKP4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:23:09 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)) 18:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:23:09 INFO - Running setup.py (path:/tmp/pip-lHxf_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:23:09 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)) 18:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:23:09 INFO - Running setup.py (path:/tmp/pip-MsUUT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:23:09 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)) 18:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:23:09 INFO - Running setup.py (path:/tmp/pip-E0_tEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:23:09 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)) 18:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:23:09 INFO - Running setup.py (path:/tmp/pip-HnnBEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:23:09 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)) 18:23:09 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)) 18:23:09 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)) 18:23:09 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)) 18:23:09 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)) 18:23:09 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)) 18:23:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:11 INFO - Downloading blessings-1.6.tar.gz 18:23:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:23:11 INFO - Installing collected packages: blessings 18:23:11 INFO - Running setup.py install for blessings 18:23:11 INFO - Successfully installed blessings 18:23:11 INFO - Cleaning up... 18:23:12 INFO - Return code: 0 18:23:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:23:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:23:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:23:12 INFO - Reading from file tmpfile_stdout 18:23:12 INFO - Current package versions: 18:23:12 INFO - argparse == 1.2.1 18:23:12 INFO - blessings == 1.6 18:23:12 INFO - blobuploader == 1.2.4 18:23:12 INFO - docopt == 0.6.1 18:23:12 INFO - functools32 == 3.2.3-2 18:23:12 INFO - jsonschema == 2.5.1 18:23:12 INFO - manifestparser == 1.1 18:23:12 INFO - mozInstall == 1.12 18:23:12 INFO - mozcrash == 0.17 18:23:12 INFO - mozdebug == 0.1 18:23:12 INFO - mozdevice == 0.48 18:23:12 INFO - mozfile == 1.2 18:23:12 INFO - mozhttpd == 0.7 18:23:12 INFO - mozinfo == 0.9 18:23:12 INFO - mozleak == 0.1 18:23:12 INFO - mozlog == 3.4 18:23:12 INFO - moznetwork == 0.27 18:23:12 INFO - mozprocess == 0.23 18:23:12 INFO - mozprofile == 0.28 18:23:12 INFO - mozrunner == 6.12 18:23:12 INFO - mozscreenshot == 0.1 18:23:12 INFO - mozsystemmonitor == 0.3 18:23:12 INFO - moztest == 0.7 18:23:12 INFO - mozversion == 1.4 18:23:12 INFO - psutil == 3.1.1 18:23:12 INFO - requests == 1.2.3 18:23:12 INFO - wsgiref == 0.1.2 18:23:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:23:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:23:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:12 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 0x7f3f32004f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b37b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2242790>, '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 0x2243690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2243b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1474505741.291732-1031377363', '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 18:23:12 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 18:23:12 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 18:23:12 INFO - Using env: {'DISPLAY': ':0', 18:23:12 INFO - 'HOME': '/home/cltbld', 18:23:12 INFO - 'LANG': 'en_US.UTF-8', 18:23:12 INFO - 'LANGUAGE': 'en_US:en', 18:23:12 INFO - 'LOGNAME': 'cltbld', 18:23:12 INFO - 'MAIL': '/var/mail/cltbld', 18:23:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:12 INFO - 'MOZ_NO_REMOTE': '1', 18:23:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:23:12 INFO - 'NO_EM_RESTART': '1', 18:23:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:23:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:12 INFO - 'PWD': '/builds/slave/test', 18:23:12 INFO - 'SHELL': '/bin/bash', 18:23:12 INFO - 'SHLVL': '1', 18:23:12 INFO - 'TERM': 'linux', 18:23:12 INFO - 'TMOUT': '86400', 18:23:12 INFO - 'USER': 'cltbld', 18:23:12 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1474505741.291732-1031377363', 18:23:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:12 INFO - '_': '/tools/buildbot/bin/python'} 18:23:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:12 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)) 18:23:12 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)) 18:23:12 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)) 18:23:12 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)) 18:23:12 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)) 18:23:12 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)) 18:23:12 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)) 18:23:12 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)) 18:23:12 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)) 18:23:12 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)) 18:23:12 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)) 18:23:12 INFO - Cleaning up... 18:23:12 INFO - Return code: 0 18:23:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:23:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:23:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3f32004f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b37b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2242790>, '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 0x2243690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2243b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1474505741.291732-1031377363', '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 18:23:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:23:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:23:12 INFO - Using env: {'DISPLAY': ':0', 18:23:12 INFO - 'HOME': '/home/cltbld', 18:23:12 INFO - 'LANG': 'en_US.UTF-8', 18:23:12 INFO - 'LANGUAGE': 'en_US:en', 18:23:12 INFO - 'LOGNAME': 'cltbld', 18:23:12 INFO - 'MAIL': '/var/mail/cltbld', 18:23:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:12 INFO - 'MOZ_NO_REMOTE': '1', 18:23:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:23:12 INFO - 'NO_EM_RESTART': '1', 18:23:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:23:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:12 INFO - 'PWD': '/builds/slave/test', 18:23:12 INFO - 'SHELL': '/bin/bash', 18:23:12 INFO - 'SHLVL': '1', 18:23:12 INFO - 'TERM': 'linux', 18:23:12 INFO - 'TMOUT': '86400', 18:23:12 INFO - 'USER': 'cltbld', 18:23:12 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1474505741.291732-1031377363', 18:23:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:12 INFO - '_': '/tools/buildbot/bin/python'} 18:23:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:23:12 INFO - Cleaning up... 18:23:12 INFO - Return code: 0 18:23:12 INFO - Running post-action listener: _resource_record_post_action 18:23:12 INFO - Running post-action listener: _start_resource_monitoring 18:23:12 INFO - Starting resource monitoring. 18:23:12 INFO - [mozharness: 2016-09-22 01:23:12.705155Z] Finished create-virtualenv step (success) 18:23:12 INFO - [mozharness: 2016-09-22 01:23:12.705685Z] Running install step. 18:23:12 INFO - Running pre-action listener: _resource_record_pre_action 18:23:12 INFO - Running main action method: install 18:23:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:23:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:23:12 INFO - Reading from file tmpfile_stdout 18:23:12 INFO - Detecting whether we're running mozinstall >=1.0... 18:23:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:23:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:23:12 INFO - Reading from file tmpfile_stdout 18:23:12 INFO - Output received: 18:23:12 INFO - Usage: mozinstall [options] installer 18:23:12 INFO - Options: 18:23:12 INFO - -h, --help show this help message and exit 18:23:12 INFO - -d DEST, --destination=DEST 18:23:12 INFO - Directory to install application into. [default: 18:23:12 INFO - "/builds/slave/test"] 18:23:12 INFO - --app=APP Application being installed. [default: firefox] 18:23:12 INFO - mkdir: /builds/slave/test/build/application 18:23:12 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'] 18:23:12 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 18:23:29 INFO - Reading from file tmpfile_stdout 18:23:29 INFO - Output received: 18:23:29 INFO - /builds/slave/test/build/application/firefox/firefox 18:23:29 INFO - Running post-action listener: _resource_record_post_action 18:23:29 INFO - [mozharness: 2016-09-22 01:23:29.928644Z] Finished install step (success) 18:23:29 INFO - [mozharness: 2016-09-22 01:23:29.928889Z] Running run-tests step. 18:23:29 INFO - Running pre-action listener: _resource_record_pre_action 18:23:29 INFO - Running main action method: run_tests 18:23:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:23:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:23:29 INFO - Python 2.7.3 18:23:29 INFO - Return code: 0 18:23:29 INFO - grabbing minidump binary from tooltool 18:23:29 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')]} 18:23:29 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 0x2242790>, '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 0x2243690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2243b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:23:29 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 18:23:29 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 18:23:29 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 18:23:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:23:30 INFO - Return code: 0 18:23:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:23:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:23:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:23:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:23:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:23:30 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/AuVVSrCjQ8q-EFfV2bbuHg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 18:23:30 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/AuVVSrCjQ8q-EFfV2bbuHg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 18:23:30 INFO - Using env: {'DISPLAY': ':0', 18:23:30 INFO - 'HOME': '/home/cltbld', 18:23:30 INFO - 'LANG': 'en_US.UTF-8', 18:23:30 INFO - 'LANGUAGE': 'en_US:en', 18:23:30 INFO - 'LOGNAME': 'cltbld', 18:23:30 INFO - 'MAIL': '/var/mail/cltbld', 18:23:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:23:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:23:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:30 INFO - 'MOZ_NO_REMOTE': '1', 18:23:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:23:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:23:30 INFO - 'NO_EM_RESTART': '1', 18:23:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:23:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:30 INFO - 'PWD': '/builds/slave/test', 18:23:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:23:30 INFO - 'SHELL': '/bin/bash', 18:23:30 INFO - 'SHLVL': '1', 18:23:30 INFO - 'TERM': 'linux', 18:23:30 INFO - 'TMOUT': '86400', 18:23:30 INFO - 'USER': 'cltbld', 18:23:30 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1474505741.291732-1031377363', 18:23:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:30 INFO - '_': '/tools/buildbot/bin/python'} 18:23:30 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/AuVVSrCjQ8q-EFfV2bbuHg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 18:23:30 INFO - mozversion application_buildid: 20160921153000 18:23:30 INFO - mozversion application_changeset: 94d6bc5adab3d63533f5c5c33df14c7d3f763859 18:23:30 INFO - mozversion application_display_name: Nightly 18:23:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:23:30 INFO - mozversion application_name: Firefox 18:23:30 INFO - mozversion application_remotingname: firefox 18:23:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:23:30 INFO - mozversion application_vendor: Mozilla 18:23:30 INFO - mozversion application_version: 52.0a1 18:23:30 INFO - mozversion platform_buildid: 20160921153000 18:23:30 INFO - mozversion platform_changeset: 94d6bc5adab3d63533f5c5c33df14c7d3f763859 18:23:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:23:30 INFO - mozversion platform_version: 52.0a1 18:23:30 INFO - using testdate: 1474507410 18:23:30 INFO - actual date: 1474507410 18:23:30 INFO - starting webserver on 'localhost:37246' 18:23:30 INFO - SUITE-START | Running 2 tests 18:23:30 INFO - TEST-START | dromaeo_css 18:23:30 INFO - operating with platform_type : linux_ 18:23:30 INFO - Initialising browser for dromaeo_css test... 18:23:30 INFO - TEST-INFO | started process 12648 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB8826G/profile http://localhost:37246/getInfo.html) 18:23:34 INFO - PROCESS | 12648 | __metrics Screen width/height:1600/1200 18:23:34 INFO - PROCESS | 12648 | colorDepth:24 18:23:34 INFO - PROCESS | 12648 | Browser inner width/height: 1024/697 18:23:34 INFO - PROCESS | 12648 | __metrics 18:23:35 INFO - PROCESS | 12648 | 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" 18:23:35 INFO - PROCESS | 12648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:23:35 INFO - PROCESS | 12648 | console.error: PushService: 18:23:35 INFO - PROCESS | 12648 | stateChangeProcessEnqueue: Error transitioning state 18:23:35 INFO - PROCESS | 12648 | UnknownError 18:23:36 INFO - TEST-INFO | 12648: exit 0 18:23:36 INFO - Browser initialized. 18:23:36 INFO - Running cycle 1/1 for dromaeo_css test... 18:23:36 INFO - TEST-INFO | started process 12732 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB8826G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:23:48 INFO - PROCESS | 12732 | RSS: Main: 173383680 18:23:48 INFO - PROCESS | 12732 | 18:24:39 INFO - PROCESS | 12732 | 1474507479548 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] 18:26:49 INFO - PROCESS | 12732 | Cycle 1(1): loaded http://localhost:37246/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37246/tests/dromaeo/cssquery-ext.html) 18:26:50 INFO - PROCESS | 12732 | RSS: Main: 306266112 18:26:50 INFO - PROCESS | 12732 | 18:29:52 INFO - PROCESS | 12732 | Cycle 1(1): loaded http://localhost:37246/tests/dromaeo/cssquery-ext.html (next: http://localhost:37246/tests/dromaeo/cssquery-jquery.html) 18:29:53 INFO - PROCESS | 12732 | RSS: Main: 275849216 18:29:53 INFO - PROCESS | 12732 | 18:32:55 INFO - PROCESS | 12732 | Cycle 1(1): loaded http://localhost:37246/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37246/tests/dromaeo/cssquery-mootools.html) 18:32:55 INFO - PROCESS | 12732 | RSS: Main: 216182784 18:32:55 INFO - PROCESS | 12732 | 18:35:57 INFO - PROCESS | 12732 | Cycle 1(1): loaded http://localhost:37246/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37246/tests/dromaeo/cssquery-prototype.html) 18:35:58 INFO - PROCESS | 12732 | RSS: Main: 257593344 18:35:58 INFO - PROCESS | 12732 | 18:39:01 INFO - PROCESS | 12732 | Cycle 1(1): loaded http://localhost:37246/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37246/tests/dromaeo/cssquery-yui.html) 18:39:01 INFO - PROCESS | 12732 | RSS: Main: 217178112 18:39:01 INFO - PROCESS | 12732 | 18:42:04 INFO - PROCESS | 12732 | Cycle 1(1): loaded http://localhost:37246/tests/dromaeo/cssquery-yui.html (next: http://localhost:37246/tests/dromaeo/cssquery-dojo.html) 18:42:04 INFO - PROCESS | 12732 | RSS: Main: 307941376 18:42:04 INFO - PROCESS | 12732 | 18:42:04 INFO - PROCESS | 12732 | __start_tp_report 18:42:04 INFO - PROCESS | 12732 | _x_x_mozilla_page_load 18:42:04 INFO - PROCESS | 12732 | _x_x_mozilla_page_load_details 18:42:04 INFO - PROCESS | 12732 | |i|pagename|runs| 18:42:04 INFO - PROCESS | 12732 | |0;dojo.html;2994.2065352681543;3013.6986301369852;3018.6679465258817;3046.5887105240786;3064.4483992881273;5130.410002849673;5177.741112944356;5201.271821944931;5246.1606143017125;5277.498637629419;5143.202803565444;5191.4548972357925;5240.580753539717;5245;5258.605604579653;4675.135100006492;4742.549457801503;4749.097671442415;4769.809207631708;4851.854444366657;4806.495317991613;4841.588464980481;4846.660733748639;4883.902321953558;4900.921797204627;4621.861344159681;4648.976755116237;4656.580907718321;4825.613950883939;4888.804447822101;4709.670323077352;4711.293306004092;4711.882202944919;4716.858494245143;4735.668503204777;4680.508546602592;4699.835505757316;4716.245400735866;4746.02706445178;4822.831200907986;5237.188235823453;5245.79016839326;5258.421573626898;5276.12943864262;5311.840644780624;5415.431379705114;5462.808801691922;5595.18869763882;5597.916031259494;5608;5528.695921724304;5578.44215578443;5580.441955804427;5592.664440133605;5598.300212473441;5187.974060129675;5212.869678258036;5213.218017297359;5215.374155101412;5275.155975043975;5524.226608274845;5569.498745112959;5689.687067211343;5689.9146512802345;5696.430356964271;5174.870628234249;5419.620626556103;5436.130219164915;5465.398806131322;5534.640248383842;5487.122060470306;5530.751116199781;5533.723313834292;5537.972310138504;5539.086050801653;5328.17413300939;5528.612997090165;5542.432849952626;5551.8889622208135;5609.8597535061135;5391.272178255886;5461.726913654381;5509.889802203934;5536.529395001389;5639.548836093103;4338.652907767371;4342.34864770287;4352.891177720519;4388.27593447084;4395.033092719596;3861;3868.5551161616772;3889.3776995680555;3894.8636797711943;3924.941125883114;5156.097682905476;5211.42674305826;5252.107141785906;5281.55106815925;5335.839924802262;5583.162525621189;5627;5637.8590535236945;5698.145278208219;5700.9429905701245;5301.310829592128;5304.946950530522;5305.787768489295;5307.336582927134;5308.097623404031;4707.270373092108;4796.208625576741;4889.168841296988;4892.437369702458;4948.282499037619;5713.74288157034;5728.684922329312;5730.971345143247;5757.107648314518;5828.0966450200285;5545.694986775766;5585.441455854545;5593.049181639212;5594.4125866785025;5618.494335509824;5490.6431081979545;5737.483626473638;5759.913601296068;5760.33756118035;5765.6540607562;5320.44135365781;5440.836774896759;5461.699606521521;5470.617056805985;5548.223248745259;5558;5578.191162281365;5578.972105139448;5616.241807356118;5620.494155525858;5442.6462279951675;5471.2887324647545;5488.780448782004;5494.917576236279;5572.442755724395;5322.627416080837;5367.677939323653;5420.864478388072;5470;5476.726163691879;5453.918191227214;5494.450554944633;5494.862628434321;5496.615236933376;5554.611177217556;5520.585956053232;5533.474319939599;5536.75084621201;5539.972300138474;5542.697703923657;5240.292560504436;5310.575153987595;5336.332958380202;5406.24312596229;5464.098423760194 18:42:04 INFO - PROCESS | 12732 | |1;ext.html;562.8220372572335;581.3750218515096;616.0051516800368;633.4615576759754;642.194046471678;32593.67406325936;42328.78835605821;43056.56943430561;43552;43635.563644363545;45471;45742;45765.31352029722;45870.08259834801;45904.770476147656;8794.648214071429;8934.374593778439;8938;8942.955285223565;8949.373543851932;8799.692010779623;8860.955695221515;8875.644974201025;8883.156100170505;8888.466691998501;8914.242289405409;8928.642854285821;8947.105289471066;8955.552222388887;8962.148595883413;8881.111888811132;8917;8921.509316987564;8926.776830579223;8939.106089391042;8820.382573219877;8914.687985920527;8915.375923685344;8920;8922.821543569156;42167.78916105431;42178.156436871395;42302.36546451806;42506.57493425088;42624.57375426237;3258.152880251128;3513.402721537345;3525.7708248963736;3535.169235229719;3812.3137835189655;31289.8435507821;31413.214669633213;31826;32158.839205804055;33132.503012454836;4335.5014173370155;4387.5393083726385;4392.978035109804;4401.5598440156045;4476.61948734358;332478;334691;335571;337559;338164;55770.72114639401;56035.15947260794;56086.71956640191;56096.43903560994;56306.43693563012;50875.236871446956;52716.20925686118;55895;58274.41725582775;58439.70780146072;17039.062851543284;17229.65540689179;17232.052237126827;17245.22396492161;17245.741313880302;13472;13563.186208827501;13578;13601.183928964294;13605.455781768618;13928.37322320498;14351.928240358731;15089;15723.21383930799;15751.291191896393;6543.928455447067;6671.666416679147;6768.289329620417;6780.457563395015;6787.966060169668;948.3077353531822;1005.7183988483237;1034.4052170002278;1048.3657387280584;1106.5186643809807;30677.386452270828;30881;31601;31690.841545792584;31770.841145794584;1047.512906498482;1110.3393480878865;1156.5200441816553;1166.1370585766472;1169.473736818435;15419.920605557727;16592.502224933272;16638.417655382003;16642.3343066276;16835.663286734198;518491;519526;521182;522254;522326;57451.42548574544;57612.711936440886;57619;57673.42326576765;57730;1296.293520031585;1300.90243231758;1324.43711422645;1325.549313233486;1330.733853229358;29360.41279174447;31034;31060.068197954097;31137.844310778302;31331.37337253288;50668.746656266485;50886.49113508966;51091.23363149481;51146.74426627992;51151.48848511467;355883;356853;356914;357512;359036;32536.34927301488;33504.822186557794;39975.400368993905;40314.348132557796;40532.1893562133;45781.31328030149;46835.29747053729;46835.29747053729;47196.05607887754;47224.527754723385;39539.97591392786;39650.2069958605;39702.20595588014;40461;41259.587404126774;40004;40120.562625586164;40304.1939161221;40627.59372406356;41797.16405671809;36907.815460922524;39325;40104;40144.39783403193;40302.39546406748;34180.31639367248;35510.46734298936;35987.64012359843;36445.58085393247;36665.45001825028;27138.457230854878;27173.184804455897;27340.316492087855;27498.862505687342;27513.44973100567 18:42:04 INFO - PROCESS | 12732 | |2;jquery.html;389.65320864430646;391.44219487230697;391.79039214020503;393.81293885404426;411.4671500406973;14019;16369.181540922966;18198.72701909471;19649.410517684475;19696.21215151394;16127.596810079755;17222.13889305536;18333.7249941251;18787.43637690868;19000.714989275137;5533.363663178746;5637.605367624268;5751.626144300607;5792.82621521355;5887.381824908387;3827.8468861245515;5796.217510636074;5829.650220986754;5832.096025116092;5835.474807267345;4020.5778393268724;5576.386597474275;5793.594448388614;5812.3025236971625;5908.438698323674;5664.688442135681;5888.852778680546;5895.528357731393;5899.705014749266;5913.172155898178;5808.59339846211;5808.854778630526;5812.041013232812;5815.941840581625;5816.970915145397;13055.804162937564;21999.780002199932;22371.32886013422;22645.433864153365;22802.885985569967;2253.1550668499312;2279.7378301495373;2281;2342.0865862313713;2451.0563433078214;9843.114119729187;9998;10311.639092631796;11269.267497612711;14365.425382984668;1887.3488646416963;1932.5072106612724;1968.9704654430195;1984.781674015857;1985.414302780683;80289.59855200745;80958.5952070236;81203.5939820303;82154.71381144747;84415;10659.786804263871;10800;10802.51388687511;10971.396573188551;11130.554777808959;13331.60005199826;15630.687386252212;15641.921790390976;15642.530724078295;15647.374105035671;7114.57312561248;8001.639926203335;8093.473924194908;8146.389020823462;8239.588020598947;7915.9208407915185;7925.801854953672;8042.437029408003;8209.630566624397;8216.465929714668;4661.580457758818;4749.382580264612;4817.6539136676765;4860.78126484302;4887.193613053877;1937.7715627029029;1943.5335519475225;1995.2019192322896;2017.459546765223;2025.6455120353878;838.2120806441925;895.2703546609623;927.3601215161517;974.4250891973769;991.2961797124123;11340.979311861973;11770.293782373084;17123.400680976105;17328.133593320283;18803.717944230848;459.8758335249464;469.53281484922036;478.91618966680693;490.5070404243712;493.2305603258928;8862.335324850534;9973.750656233653;10114.342567733074;10254.48727563619;10506.947465262625;458416;463246;463677;472007;475438;86702;86923.52305907819;87152;93693;96529.51735241279;471.48608017262035;483.3450674336224;499.6003197442104;499.7551199912017;501.59120316942307;10100.696979090639;10637.734056648645;10643.308184967953;10832.566697332019;11099.500522476346;40999;41860.58139418567;42437;42457.15085698207;42773.14453710971;51137.48862511327;56645.43354566402;57475.42524574701;57523.7123814395;57760;5864.266966629171;8312.459690120122;8486.83026339482;8521.190486903733;8715;7924.920750792418;11247.718807029562;12118.848709372596;12245.75508489843;12628.873711263137;9899.059589339002;11127.221094523306;11551.191416600757;11609.825852612048;11792.29246245228;10875.184361172785;10905.34567925927;11292.943535282271;11539.423028848692;11662.941685291858;11566.884331156918;11770.293782373084;11904.702382440508;11988.880111198776;12008.159428839897;8485.236328730443;8491.19333663301;8795.560221988748;8796.736097917073;9130.223930965676;10612.575496980035;11378.658640240807;11568.305901645928;11598.652040438801;11753.823692644446 18:42:04 INFO - PROCESS | 12732 | |3;mootools.html;1297.7534268488992;1465.428482891672;1480.21548579253;1588.1900230882254;1720.5224476753474;7518.624068796559;8806.955965220173;9109.45343279403;9143.588538515765;9393.342466027381;9216.032316606761;9283.257339412849;9293.860592091123;9294.117058879412;9301.488418137;2301.631738921769;2327.104064935004;2330.3009097270838;2331.8484298520625;2335.381124002141;2270.182734215681;2325.244295603927;2407.987960060197;2409.891554880026;2411.867347295898;2312.7687231276905;2320.071971211512;2326.9883650581723;2335.1243283768586;2342.824288178385;2304.34326217029;2330.2892617751577;2331.568659797943;2334.26470661741;2345.624700048001;2317.142657216824;2327.1622216002224;2331.6968794056834;2334.4397344637337;2338.2166974063707;8600.311975041981;8891.33315001371;9142.862857057149;9208.585613647401;9209.447433154031;5342.679439233659;5482.835514934558;5487.42382049883;5491.066518691832;5494.066008778517;3482.7562070655063;3529.8941031769086;3542.5926018507944;3556.982215088934;3610.2598967211657;1107.5016242690822;1127.870294916087;1128.5147386623748;1139.0545846947098;1144.3648774929911;12599.622011339674;12624.116311858174;12666.87333126666;12674.239545627384;12693.365331733468;4421.226285400042;4587.357769912215;4663.860084197479;4707.505711900201;4807.302941073594;9468.857967130498;9477.194438472807;9481.66814161501;9482.857757133648;9488.620455181854;5232.869178270574;5242.397124330751;5242.842714718565;5245.632805703564;5246.658967167198;4270.508891477458;4291.6137547620865;4426.490953540319;4910.90178196434;4977.352944117314;3780.3951367781024;3907.7459965102175;3983.2630963271886;3996.960030399659;4015.3575427931974;1132.5300000499865;1150.8216226484908;1185.1289302362757;1185.3006726031683;1189.41718557906;796.7609717084852;877.9648814047366;891.4116682989196;910.5583791860943;922.1792604581927;5753.252077229933;5860.179574859523;5871.94128058714;5940.405959404025;5948.524118070631;851.7572491839796;891.0332289466002;920.4339331311329;954.8949615542285;992.2359782967075;3835.290471262825;3876.4960555127655;3936;3942.7634341939574;4031.6169963853386;10809.405482698527;11224.551017959353;11249.156313276537;11365.204435689588;11366.602168924213;11241.94379028116;11262.662120136409;11265.831012534818;11274.887251127384;11292.435378231055;8296;8345.374096942754;8743.51910644908;8751.431156974904;8764.737057888273;5600.81568188415;5878.911816322673;5927.081302398135;6030.095485677008;6102.633841969496;10208.540615672164;10313.845292320471;10321.587136514456;10338.689839304832;10445.164386848883;10140.949295253771;10605.310654807412;10692.62575809843;10722.463876805972;10736.89263107359;6951.617661028692;7136.6788494518905;7783.92216077832;8086.5148091114725;8237.629306681094;8687.522186279815;9041.18629323364;9073.818523629358;9131.497767622845;9146.634134634805;7591.8861217080685;7735.497192682457;7741.225877412214;7853.09689385728;7879.763607091796;7389.778306650809;7580.128285247267;7610.505317154589;7667.386609071149;7803.180666029985;7265.7093716252875;7374.373178279906;7377.926220737724;7387.261273872569;7395.371393431618;5015.147424937696;5031;5112.795488180431;5118.641695081308;5225.6603320784025;5024.120778863758;5024.924626130538;5093.286939828501;5156.56169225605;5158.4583618721 18:42:04 INFO - PROCESS | 12732 | |4;prototype.html;301.56875667795043;306.1382209081436;311.90642807157855;313.55944897419135;316.56788483719714;5105.872353191172;5264.763085661145;5286.8413947581585;5348.251244825723;5349.8127565535215;5138.280640710294;5239;5270.683758974455;5271.525562699357;5273.235380869772;4110.362893751473;4125.113100683352;4136.172765446908;4138.772367519785;4138.937915931264;3951.604839516054;4087.305158123126;4110;4110.753354798721;4157.750534967897;4086.7126855040715;4088.6115818997146;4094.6928980326447;4100.1594673092095;4110.568390319018;4076.857309994151;4080.775557344345;4099.221147981874;4115.34154535273;4118.464599602063;3595;3599.748017638766;3604.1530240393486;3621.2938476996997;3630;5115.462876397962;5138.7173705446185;5183.948160518385;5186.7147306898105;5209.687418754849;4662.743549104832;4671.299305104228;4685.718856868565;4689.906201875978;4700.824793801549;5512.972435137839;5514.393416724157;5514.558835293167;5556.805062000528;5578.972105139448;3698.6486283802997;3850.942235866464;3865.632764887331;3870.0518372998513;3884.8057597120314;5734.39788822176;5766.481016708516;5774.393688662672;5778.479936805666;5779.508741756914;3980.283548961157;4008.178323443687;4045.1505183911117;4045.959540404617;4051.149258655715;3916.2559113768293;3989.9202015959518;3999.7400168988925;4017.7187596868525;4087.2029954159248;4620.699654522446;4628.213203755369;4634.328022436728;4638.5593368629925;4662.417197850269;5641.351244606841;5644.57665675076;5647.604667673223;5653.321601407775;5672.319321681342;1321.6717199214727;1359.157322460081;1362.8500864904852;1393.3451277899371;1407.936642851074;925.9444433334022;931.329442801182;933.7338858425317;955.3360414511986;963.0658261486348;5292.44429334922;5306.92039619406;5322.414534401213;5328.641196494869;5342.2253773202665;5587.69267690281;5601.383847776741;5624.578156638268;5632.000639772904;5634.60557760961;5155.9742201288755;5298.788048478018;5321;5353.625246232727;5376.677399356051;2646.087099950514;2649.4701059787735;2650.681918169832;2678.8124831262016;2703.5535988246193;5206.947930520722;5219.817306394334;5221.564069880737;5235.319408476874;5271.182966640177;4734.047070696008;5046.192609182586;5053.898922021539;5082.923756143587;5100.464451232641;5100.413452452941;5104.974475127675;5118.25785261135;5121.2574176744165;5122.385313762373;4890.266460031024;4901.6323775716255;4928.211486162197;4988.9501104988485;5020.974895125647;4620.124731460148;4820.734859582616;4929.507049295042;4957.785342591088;4981.775820088033;5113.207452844815;5117.232415137759;5132.6150538709;5132.717700526507;5178.6374953752875;3627.3676845420196;3630.4917311575873;3645.76302540334;3658.6158453363078;3659.945100823543;4778.211595086911;4893.535114164149;4969.35398398206;5088.033273677989;5357.794496238315;5357.544608708304;5412.621116521963;5540.307461567304;5548.9722551386985;5568.192612071146;5486;5494.917576236279;5503.2020357048805;5567.582431317586;5575.972120139373;5331.333583302087;5478.534324582455;5524.779008839762;5527.640703354269;5546.528545073553;5516.80691175823;5547.140193270049;5552;5594.1608758686525;5604.467575580314;5377.677339359651;5444.918326225189;5465.535429488538;5479.123340265538;5492.286002819608 18:42:04 INFO - PROCESS | 12732 | |5;yui.html;739.2792027772922;744.009339691711;773.5822655765887;787.6258777080888;833.3791325462523;16033.83966160338;16657.583560410996;16718.582035449104;16759;17081.316747330093;16923.492295231164;17082.231299591516;17087.914560427213;17101.40145094922;17110.486685399428;661.7419206509466;677.701811203069;800.0599295827394;819.8442295963748;823.2097186700775;794.047143427886;815.135955886759;823.333100188846;824.5382585751998;825.0759149752286;851.7700220940343;860.0410542245382;860.9698660546882;861.1001503428931;863.5466380150408;685.5132855672479;702.6381413572014;856.567433446112;857.8927634045745;858.6436628799041;601.0533409879457;614.0788816774838;619.2321521313584;619.5477301569834;619.6158381803266;14741.55775326742;14742.631434214123;14786.482473113389;14835.851641483556;14916.776248356284;13464.663383415394;14037.368318425695;14344.928275358556;14383.208923509203;14403.423863045466;12982.221066736027;13028.739425211537;13138.014648901275;13150.736985260337;13151.60545183646;3870.748401353931;3900.161465284949;4464.776761161961;4523.728576285401;4586.082783443291;81459;82986;84992;85130;87115.56442217811;10633.361998280128;10763.408012559228;10947.671569852917;11132.387718675389;11231.326120432801;21779;21812.236571719914;21816.890915545322;21817.67273490899;21832.89083554572;8361.95819020901;8538.487690738451;8801.647934082564;8892.28861691076;8956.552172391484;4820.156472617278;4924.630652701062;4952.8761780955765;4960.107180707435;5078.4413714491375;3408.880689175867;3523.9647603523636;3531.5055892175114;3535.1338921964284;3536.6463353664944;578.7974209026806;583.1981026089128;584.333859400284;585.1193953100642;591.9792807251725;625.4948929537175;710.8009757267973;721.2859269323333;739.061392032127;742.7474658615988;10094.545745441474;10263.846042309371;10501.159907207406;10863.239573229797;11194.888051119548;654.0320325917669;671.4225765841372;726.9745558905413;731.8353370491596;771.1902502372486;4349;4620.735839438651;4646.442426908792;4701.529847015271;4712.293156026623;96883;115982.42008789902;116608;124598;125267;95449;100526;101748.49125754324;104010;106011;89078.9999999987;89256.75202735876;89835.55082224678;89960;90770.54614727016;9030.909690903007;9148.771280718036;9204.769880753034;9330.486823224788;9374.812503750023;44628.77685611681;51849.48150518598;52182.47817521776;52797.736011321234;53205.73397132989;68700;69928.6503567479;75761.62119189369;75949;78857;12779.913707334981;12881.935590322364;12948.935255323662;13362.398692058687;13413.530526431528;13199.934000329937;13250.469981200644;13368.398422070835;13437.193768373929;13655.931720341334;13173.209607423585;13451.394687238902;14208.928955355157;14313.64215894611;14423.567292980808;11633.883661163618;11797.410129493663;11971.521139154336;12335.198212116184;12424.937875310565;12737.872621274038;13833.792493112813;14021.5092471763;14274.857251427353;15395.230238488255;11733.237339572901;11756.177067605186;11798.292102473879;11996.893234819905;12011.279323240633;12131.75736485283;12231.877681223074;12417.19288246261;12588.244705317711;12769.8084528734 18:42:04 INFO - PROCESS | 12732 | __end_tp_report 18:42:04 INFO - PROCESS | 12732 | __start_cc_report 18:42:04 INFO - PROCESS | 12732 | _x_x_mozilla_cycle_collect,1012 18:42:04 INFO - PROCESS | 12732 | __end_cc_report 18:42:04 INFO - PROCESS | 12732 | __startTimestamp1474508524887__endTimestamp 18:42:04 INFO - PROCESS | 12732 | 18:42:04 INFO - PROCESS | 12732 | ------- Summary: start ------- 18:42:04 INFO - PROCESS | 12732 | Number of tests: 6 18:42:04 INFO - PROCESS | 12732 | 18:42:04 INFO - PROCESS | 12732 | [#0] dojo.html Cycles:165 Average:5184.78 Median:5367.68 stddev:569.60 (10.6%) stddev-sans-first:544.81 18:42:04 INFO - PROCESS | 12732 | Values: 2994.2 3013.7 3018.7 3046.6 3064.4 5130.4 5177.7 5201.3 5246.2 5277.5 5143.2 5191.5 5240.6 5245.0 5258.6 4675.1 4742.5 4749.1 4769.8 4851.9 4806.5 4841.6 4846.7 4883.9 4900.9 4621.9 4649.0 4656.6 4825.6 4888.8 4709.7 4711.3 4711.9 4716.9 4735.7 4680.5 4699.8 4716.2 4746.0 4822.8 5237.2 5245.8 5258.4 5276.1 5311.8 5415.4 5462.8 5595.2 5597.9 5608.0 5528.7 5578.4 5580.4 5592.7 5598.3 5188.0 5212.9 5213.2 5215.4 5275.2 5524.2 5569.5 5689.7 5689.9 5696.4 5174.9 5419.6 5436.1 5465.4 5534.6 5487.1 5530.8 5533.7 5538.0 5539.1 5328.2 5528.6 5542.4 5551.9 5609.9 5391.3 5461.7 5509.9 5536.5 5639.5 4338.7 4342.3 4352.9 4388.3 4395.0 3861.0 3868.6 3889.4 3894.9 3924.9 5156.1 5211.4 5252.1 5281.6 5335.8 5583.2 5627.0 5637.9 5698.1 5700.9 5301.3 5304.9 5305.8 5307.3 5308.1 4707.3 4796.2 4889.2 4892.4 4948.3 5713.7 5728.7 5731.0 5757.1 5828.1 5545.7 5585.4 5593.0 5594.4 5618.5 5490.6 5737.5 5759.9 5760.3 5765.7 5320.4 5440.8 5461.7 5470.6 5548.2 5558.0 5578.2 5579.0 5616.2 5620.5 5442.6 5471.3 5488.8 5494.9 5572.4 5322.6 5367.7 5420.9 5470.0 5476.7 5453.9 5494.5 5494.9 5496.6 5554.6 5520.6 5533.5 5536.8 5540.0 5542.7 5240.3 5310.6 5336.3 5406.2 5464.1 18:42:04 INFO - PROCESS | 12732 | 18:42:04 INFO - PROCESS | 12732 | [#1] ext.html Cycles:180 Average:56930.60 Median:40496.59 stddev:109260.05 (269.8%) stddev-sans-first:109484.59 18:42:04 INFO - PROCESS | 12732 | Values: 562.8 581.4 616.0 633.5 642.2 32593.7 42328.8 43056.6 43552.0 43635.6 45471.0 45742.0 45765.3 45870.1 45904.8 8794.6 8934.4 8938.0 8943.0 8949.4 8799.7 8861.0 8875.6 8883.2 8888.5 8914.2 8928.6 8947.1 8955.6 8962.1 8881.1 8917.0 8921.5 8926.8 8939.1 8820.4 8914.7 8915.4 8920.0 8922.8 42167.8 42178.2 42302.4 42506.6 42624.6 3258.2 3513.4 3525.8 3535.2 3812.3 31289.8 31413.2 31826.0 32158.8 33132.5 4335.5 4387.5 4393.0 4401.6 4476.6 332478.0 334691.0 335571.0 337559.0 338164.0 55770.7 56035.2 56086.7 56096.4 56306.4 50875.2 52716.2 55895.0 58274.4 58439.7 17039.1 17229.7 17232.1 17245.2 17245.7 13472.0 13563.2 13578.0 13601.2 13605.5 13928.4 14351.9 15089.0 15723.2 15751.3 6543.9 6671.7 6768.3 6780.5 6788.0 948.3 1005.7 1034.4 1048.4 1106.5 30677.4 30881.0 31601.0 31690.8 31770.8 1047.5 1110.3 1156.5 1166.1 1169.5 15419.9 16592.5 16638.4 16642.3 16835.7 518491.0 519526.0 521182.0 522254.0 522326.0 57451.4 57612.7 57619.0 57673.4 57730.0 1296.3 1300.9 1324.4 1325.5 1330.7 29360.4 31034.0 31060.1 31137.8 31331.4 50668.7 50886.5 51091.2 51146.7 51151.5 355883.0 356853.0 356914.0 357512.0 359036.0 32536.3 33504.8 39975.4 40314.3 40532.2 45781.3 46835.3 46835.3 47196.1 47224.5 39540.0 39650.2 39702.2 40461.0 41259.6 40004.0 40120.6 40304.2 40627.6 41797.2 36907.8 39325.0 40104.0 40144.4 40302.4 34180.3 35510.5 35987.6 36445.6 36665.5 27138.5 27173.2 27340.3 27498.9 27513.4 18:42:04 INFO - PROCESS | 12732 | 18:42:04 INFO - PROCESS | 12732 | [#2] jquery.html Cycles:180 Average:27697.46 Median:250594.57 stddev:77133.75 (30.8%) stddev-sans-first:77322.87 18:42:04 INFO - PROCESS | 12732 | Values: 389.7 391.4 391.8 393.8 411.5 14019.0 16369.2 18198.7 19649.4 19696.2 16127.6 17222.1 18333.7 18787.4 19000.7 5533.4 5637.6 5751.6 5792.8 5887.4 3827.8 5796.2 5829.7 5832.1 5835.5 4020.6 5576.4 5793.6 5812.3 5908.4 5664.7 5888.9 5895.5 5899.7 5913.2 5808.6 5808.9 5812.0 5815.9 5817.0 13055.8 21999.8 22371.3 22645.4 22802.9 2253.2 2279.7 2281.0 2342.1 2451.1 9843.1 9998.0 10311.6 11269.3 14365.4 1887.3 1932.5 1969.0 1984.8 1985.4 80289.6 80958.6 81203.6 82154.7 84415.0 10659.8 10800.0 10802.5 10971.4 11130.6 13331.6 15630.7 15641.9 15642.5 15647.4 7114.6 8001.6 8093.5 8146.4 8239.6 7915.9 7925.8 8042.4 8209.6 8216.5 4661.6 4749.4 4817.7 4860.8 4887.2 1937.8 1943.5 1995.2 2017.5 2025.6 838.2 895.3 927.4 974.4 991.3 11341.0 11770.3 17123.4 17328.1 18803.7 459.9 469.5 478.9 490.5 493.2 8862.3 9973.8 10114.3 10254.5 10506.9 458416.0 463246.0 463677.0 472007.0 475438.0 86702.0 86923.5 87152.0 93693.0 96529.5 471.5 483.3 499.6 499.8 501.6 10100.7 10637.7 10643.3 10832.6 11099.5 40999.0 41860.6 42437.0 42457.2 42773.1 51137.5 56645.4 57475.4 57523.7 57760.0 5864.3 8312.5 8486.8 8521.2 8715.0 7924.9 11247.7 12118.8 12245.8 12628.9 9899.1 11127.2 11551.2 11609.8 11792.3 10875.2 10905.3 11292.9 11539.4 11662.9 11566.9 11770.3 11904.7 11988.9 12008.2 8485.2 8491.2 8795.6 8796.7 9130.2 10612.6 11378.7 11568.3 11598.7 11753.8 18:42:04 INFO - PROCESS | 12732 | 18:42:04 INFO - PROCESS | 12732 | [#3] mootools.html Cycles:180 Average:5864.95 Median:5019.63 stddev:3393.79 (67.6%) stddev-sans-first:3385.95 18:42:04 INFO - PROCESS | 12732 | Values: 1297.8 1465.4 1480.2 1588.2 1720.5 7518.6 8807.0 9109.5 9143.6 9393.3 9216.0 9283.3 9293.9 9294.1 9301.5 2301.6 2327.1 2330.3 2331.8 2335.4 2270.2 2325.2 2408.0 2409.9 2411.9 2312.8 2320.1 2327.0 2335.1 2342.8 2304.3 2330.3 2331.6 2334.3 2345.6 2317.1 2327.2 2331.7 2334.4 2338.2 8600.3 8891.3 9142.9 9208.6 9209.4 5342.7 5482.8 5487.4 5491.1 5494.1 3482.8 3529.9 3542.6 3557.0 3610.3 1107.5 1127.9 1128.5 1139.1 1144.4 12599.6 12624.1 12666.9 12674.2 12693.4 4421.2 4587.4 4663.9 4707.5 4807.3 9468.9 9477.2 9481.7 9482.9 9488.6 5232.9 5242.4 5242.8 5245.6 5246.7 4270.5 4291.6 4426.5 4910.9 4977.4 3780.4 3907.7 3983.3 3997.0 4015.4 1132.5 1150.8 1185.1 1185.3 1189.4 796.8 878.0 891.4 910.6 922.2 5753.3 5860.2 5871.9 5940.4 5948.5 851.8 891.0 920.4 954.9 992.2 3835.3 3876.5 3936.0 3942.8 4031.6 10809.4 11224.6 11249.2 11365.2 11366.6 11241.9 11262.7 11265.8 11274.9 11292.4 8296.0 8345.4 8743.5 8751.4 8764.7 5600.8 5878.9 5927.1 6030.1 6102.6 10208.5 10313.8 10321.6 10338.7 10445.2 10140.9 10605.3 10692.6 10722.5 10736.9 6951.6 7136.7 7783.9 8086.5 8237.6 8687.5 9041.2 9073.8 9131.5 9146.6 7591.9 7735.5 7741.2 7853.1 7879.8 7389.8 7580.1 7610.5 7667.4 7803.2 7265.7 7374.4 7377.9 7387.3 7395.4 5015.1 5031.0 5112.8 5118.6 5225.7 5024.1 5024.9 5093.3 5156.6 5158.5 18:42:04 INFO - PROCESS | 12732 | 18:42:04 INFO - PROCESS | 12732 | [#4] prototype.html Cycles:180 Average:4494.78 Median:5105.42 stddev:1315.74 (25.8%) stddev-sans-first:1281.24 18:42:04 INFO - PROCESS | 12732 | Values: 301.6 306.1 311.9 313.6 316.6 5105.9 5264.8 5286.8 5348.3 5349.8 5138.3 5239.0 5270.7 5271.5 5273.2 4110.4 4125.1 4136.2 4138.8 4138.9 3951.6 4087.3 4110.0 4110.8 4157.8 4086.7 4088.6 4094.7 4100.2 4110.6 4076.9 4080.8 4099.2 4115.3 4118.5 3595.0 3599.7 3604.2 3621.3 3630.0 5115.5 5138.7 5183.9 5186.7 5209.7 4662.7 4671.3 4685.7 4689.9 4700.8 5513.0 5514.4 5514.6 5556.8 5579.0 3698.6 3850.9 3865.6 3870.1 3884.8 5734.4 5766.5 5774.4 5778.5 5779.5 3980.3 4008.2 4045.2 4046.0 4051.1 3916.3 3989.9 3999.7 4017.7 4087.2 4620.7 4628.2 4634.3 4638.6 4662.4 5641.4 5644.6 5647.6 5653.3 5672.3 1321.7 1359.2 1362.9 1393.3 1407.9 925.9 931.3 933.7 955.3 963.1 5292.4 5306.9 5322.4 5328.6 5342.2 5587.7 5601.4 5624.6 5632.0 5634.6 5156.0 5298.8 5321.0 5353.6 5376.7 2646.1 2649.5 2650.7 2678.8 2703.6 5206.9 5219.8 5221.6 5235.3 5271.2 4734.0 5046.2 5053.9 5082.9 5100.5 5100.4 5105.0 5118.3 5121.3 5122.4 4890.3 4901.6 4928.2 4989.0 5021.0 4620.1 4820.7 4929.5 4957.8 4981.8 5113.2 5117.2 5132.6 5132.7 5178.6 3627.4 3630.5 3645.8 3658.6 3659.9 4778.2 4893.5 4969.4 5088.0 5357.8 5357.5 5412.6 5540.3 5549.0 5568.2 5486.0 5494.9 5503.2 5567.6 5576.0 5331.3 5478.5 5524.8 5527.6 5546.5 5516.8 5547.1 5552.0 5594.2 5604.5 5377.7 5444.9 5465.5 5479.1 5492.3 18:42:04 INFO - PROCESS | 12732 | 18:42:04 INFO - PROCESS | 12732 | [#5] yui.html Cycles:180 Average:21333.27 Median:24488.89 stddev:30822.64 (125.9%) stddev-sans-first:30870.31 18:42:04 INFO - PROCESS | 12732 | Values: 739.3 744.0 773.6 787.6 833.4 16033.8 16657.6 16718.6 16759.0 17081.3 16923.5 17082.2 17087.9 17101.4 17110.5 661.7 677.7 800.1 819.8 823.2 794.0 815.1 823.3 824.5 825.1 851.8 860.0 861.0 861.1 863.5 685.5 702.6 856.6 857.9 858.6 601.1 614.1 619.2 619.5 619.6 14741.6 14742.6 14786.5 14835.9 14916.8 13464.7 14037.4 14344.9 14383.2 14403.4 12982.2 13028.7 13138.0 13150.7 13151.6 3870.7 3900.2 4464.8 4523.7 4586.1 81459.0 82986.0 84992.0 85130.0 87115.6 10633.4 10763.4 10947.7 11132.4 11231.3 21779.0 21812.2 21816.9 21817.7 21832.9 8362.0 8538.5 8801.6 8892.3 8956.6 4820.2 4924.6 4952.9 4960.1 5078.4 3408.9 3524.0 3531.5 3535.1 3536.6 578.8 583.2 584.3 585.1 592.0 625.5 710.8 721.3 739.1 742.7 10094.5 10263.8 10501.2 10863.2 11194.9 654.0 671.4 727.0 731.8 771.2 4349.0 4620.7 4646.4 4701.5 4712.3 96883.0 115982.4 116608.0 124598.0 125267.0 95449.0 100526.0 101748.5 104010.0 106011.0 89079.0 89256.8 89835.6 89960.0 90770.5 9030.9 9148.8 9204.8 9330.5 9374.8 44628.8 51849.5 52182.5 52797.7 53205.7 68700.0 69928.7 75761.6 75949.0 78857.0 12779.9 12881.9 12948.9 13362.4 13413.5 13199.9 13250.5 13368.4 13437.2 13655.9 13173.2 13451.4 14208.9 14313.6 14423.6 11633.9 11797.4 11971.5 12335.2 12424.9 12737.9 13833.8 14021.5 14274.9 15395.2 11733.2 11756.2 11798.3 11996.9 12011.3 12131.8 12231.9 12417.2 12588.2 12769.8 18:42:04 INFO - PROCESS | 12732 | -------- Summary: end -------- 18:42:04 INFO - PROCESS | 12732 | 18:42:05 INFO - TEST-INFO | 12732: exit 0 18:42:05 INFO - TEST-OK | dromaeo_css | took 1115586ms 18:42:05 INFO - TEST-START | kraken 18:42:05 INFO - operating with platform_type : linux_ 18:42:05 INFO - Initialising browser for kraken test... 18:42:05 INFO - TEST-INFO | started process 13038 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4dTsTa/profile http://localhost:37246/getInfo.html) 18:42:09 INFO - PROCESS | 13038 | __metrics Screen width/height:1600/1200 18:42:09 INFO - PROCESS | 13038 | colorDepth:24 18:42:09 INFO - PROCESS | 13038 | Browser inner width/height: 1024/697 18:42:09 INFO - PROCESS | 13038 | __metrics 18:42:10 INFO - PROCESS | 13038 | 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" 18:42:10 INFO - PROCESS | 13038 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:42:10 INFO - PROCESS | 13038 | console.error: PushService: 18:42:10 INFO - PROCESS | 13038 | stateChangeProcessEnqueue: Error transitioning state 18:42:10 INFO - PROCESS | 13038 | UnknownError 18:42:11 INFO - TEST-INFO | 13038: exit 0 18:42:11 INFO - Browser initialized. 18:42:11 INFO - Running cycle 1/1 for kraken test... 18:42:11 INFO - TEST-INFO | started process 13122 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4dTsTa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:42:23 INFO - PROCESS | 13122 | RSS: Main: 173473792 18:42:23 INFO - PROCESS | 13122 | 18:42:26 INFO - PROCESS | 13122 | Cycle 1(1): loaded http://localhost:37246/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37246/tests/kraken/driver.html?testName=audio-beat-detection) 18:42:27 INFO - PROCESS | 13122 | RSS: Main: 232296448 18:42:27 INFO - PROCESS | 13122 | 18:42:29 INFO - PROCESS | 13122 | Cycle 1(1): loaded http://localhost:37246/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37246/tests/kraken/driver.html?testName=audio-dft) 18:42:30 INFO - PROCESS | 13122 | RSS: Main: 217665536 18:42:30 INFO - PROCESS | 13122 | 18:42:33 INFO - PROCESS | 13122 | Cycle 1(1): loaded http://localhost:37246/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37246/tests/kraken/driver.html?testName=audio-fft) 18:42:34 INFO - PROCESS | 13122 | RSS: Main: 298426368 18:42:34 INFO - PROCESS | 13122 | 18:42:36 INFO - PROCESS | 13122 | Cycle 1(1): loaded http://localhost:37246/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37246/tests/kraken/driver.html?testName=audio-oscillator) 18:42:36 INFO - PROCESS | 13122 | RSS: Main: 209145856 18:42:36 INFO - PROCESS | 13122 | 18:42:38 INFO - PROCESS | 13122 | Cycle 1(1): loaded http://localhost:37246/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37246/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:42:39 INFO - PROCESS | 13122 | RSS: Main: 213286912 18:42:39 INFO - PROCESS | 13122 | 18:42:42 INFO - PROCESS | 13122 | Cycle 1(1): loaded http://localhost:37246/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37246/tests/kraken/driver.html?testName=imaging-darkroom) 18:42:43 INFO - PROCESS | 13122 | RSS: Main: 249499648 18:42:43 INFO - PROCESS | 13122 | 18:42:46 INFO - PROCESS | 13122 | Cycle 1(1): loaded http://localhost:37246/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37246/tests/kraken/driver.html?testName=imaging-desaturate) 18:42:47 INFO - PROCESS | 13122 | RSS: Main: 248729600 18:42:47 INFO - PROCESS | 13122 | 18:42:49 INFO - PROCESS | 13122 | Cycle 1(1): loaded http://localhost:37246/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37246/tests/kraken/driver.html?testName=json-parse-financial) 18:42:50 INFO - PROCESS | 13122 | RSS: Main: 248115200 18:42:50 INFO - PROCESS | 13122 | 18:42:51 INFO - PROCESS | 13122 | Cycle 1(1): loaded http://localhost:37246/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37246/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:42:52 INFO - PROCESS | 13122 | RSS: Main: 210661376 18:42:52 INFO - PROCESS | 13122 | 18:42:54 INFO - PROCESS | 13122 | Cycle 1(1): loaded http://localhost:37246/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37246/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:42:54 INFO - PROCESS | 13122 | RSS: Main: 217649152 18:42:54 INFO - PROCESS | 13122 | 18:42:56 INFO - PROCESS | 13122 | Cycle 1(1): loaded http://localhost:37246/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37246/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:42:57 INFO - PROCESS | 13122 | RSS: Main: 222384128 18:42:57 INFO - PROCESS | 13122 | 18:43:00 INFO - PROCESS | 13122 | Cycle 1(1): loaded http://localhost:37246/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:43:00 INFO - PROCESS | 13122 | RSS: Main: 223186944 18:43:00 INFO - PROCESS | 13122 | 18:43:03 INFO - PROCESS | 13122 | Cycle 1(1): loaded http://localhost:37246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:43:04 INFO - PROCESS | 13122 | RSS: Main: 221220864 18:43:04 INFO - PROCESS | 13122 | 18:43:05 INFO - PROCESS | 13122 | Cycle 1(1): loaded http://localhost:37246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37246/tests/kraken/driver.html?testName=ai-astar) 18:43:06 INFO - PROCESS | 13122 | RSS: Main: 272855040 18:43:06 INFO - PROCESS | 13122 | 18:43:06 INFO - PROCESS | 13122 | __start_tp_report 18:43:06 INFO - PROCESS | 13122 | _x_x_mozilla_page_load 18:43:06 INFO - PROCESS | 13122 | _x_x_mozilla_page_load_details 18:43:06 INFO - PROCESS | 13122 | |i|pagename|runs| 18:43:06 INFO - PROCESS | 13122 | |0;ai-astar;110;112;120;111;113;112;112;111;110;112 18:43:06 INFO - PROCESS | 13122 | |1;audio-beat-detection;147;122;123;157;124;118;123;119;146;118 18:43:06 INFO - PROCESS | 13122 | |2;audio-dft;161;160;162;163;162;162;162;162;162;162 18:43:06 INFO - PROCESS | 13122 | |3;audio-fft;74;77;75;111;75;75;76;76;114;77 18:43:06 INFO - PROCESS | 13122 | |4;audio-oscillator;82;82;116;83;83;83;109;82;82;112 18:43:06 INFO - PROCESS | 13122 | |5;imaging-gaussian-blur;117;117;117;118;117;117;117;118;118;117 18:43:06 INFO - PROCESS | 13122 | |6;imaging-darkroom;146;147;146;147;146;146;147;147;147;148 18:43:06 INFO - PROCESS | 13122 | |7;imaging-desaturate;96;96;96;96;95;96;95;95;95;95 18:43:06 INFO - PROCESS | 13122 | |8;json-parse-financial;55;52;52;53;53;58;52;52;53;54 18:43:06 INFO - PROCESS | 13122 | |9;json-stringify-tinderbox;60;62;61;61;62;61;60;60;60;60 18:43:06 INFO - PROCESS | 13122 | |10;stanford-crypto-aes;88;83;79;79;92;78;79;80;88;78 18:43:06 INFO - PROCESS | 13122 | |11;stanford-crypto-ccm;126;140;123;127;131;124;124;133;177;131 18:43:06 INFO - PROCESS | 13122 | |12;stanford-crypto-pbkdf2;166;165;163;166;163;166;167;162;167;165 18:43:06 INFO - PROCESS | 13122 | |13;stanford-crypto-sha256-iterative;65;68;66;64;67;64;64;65;68;65 18:43:06 INFO - PROCESS | 13122 | __end_tp_report 18:43:06 INFO - PROCESS | 13122 | __start_cc_report 18:43:06 INFO - PROCESS | 13122 | _x_x_mozilla_cycle_collect,1655 18:43:06 INFO - PROCESS | 13122 | __end_cc_report 18:43:06 INFO - PROCESS | 13122 | __startTimestamp1474508586120__endTimestamp 18:43:06 INFO - PROCESS | 13122 | 18:43:06 INFO - PROCESS | 13122 | ------- Summary: start ------- 18:43:06 INFO - PROCESS | 13122 | Number of tests: 14 18:43:06 INFO - PROCESS | 13122 | 18:43:06 INFO - PROCESS | 13122 | [#0] ai-astar Cycles:10 Average:112.30 Median:112.00 stddev:2.87 (2.6%) stddev-sans-first:2.92 18:43:06 INFO - PROCESS | 13122 | Values: 110.0 112.0 120.0 111.0 113.0 112.0 112.0 111.0 110.0 112.0 18:43:06 INFO - PROCESS | 13122 | 18:43:06 INFO - PROCESS | 13122 | [#1] audio-beat-detection Cycles:10 Average:129.70 Median:123.50 stddev:14.45 (11.7%) stddev-sans-first:13.91 18:43:06 INFO - PROCESS | 13122 | Values: 147.0 122.0 123.0 157.0 124.0 118.0 123.0 119.0 146.0 118.0 18:43:06 INFO - PROCESS | 13122 | 18:43:06 INFO - PROCESS | 13122 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 18:43:06 INFO - PROCESS | 13122 | Values: 161.0 160.0 162.0 163.0 162.0 162.0 162.0 162.0 162.0 162.0 18:43:06 INFO - PROCESS | 13122 | 18:43:06 INFO - PROCESS | 13122 | [#3] audio-fft Cycles:10 Average:83.00 Median:75.50 stddev:15.59 (20.7%) stddev-sans-first:16.19 18:43:06 INFO - PROCESS | 13122 | Values: 74.0 77.0 75.0 111.0 75.0 75.0 76.0 76.0 114.0 77.0 18:43:06 INFO - PROCESS | 13122 | 18:43:06 INFO - PROCESS | 13122 | [#4] audio-oscillator Cycles:10 Average:91.40 Median:82.00 stddev:14.55 (17.7%) stddev-sans-first:15.03 18:43:06 INFO - PROCESS | 13122 | Values: 82.0 82.0 116.0 83.0 83.0 83.0 109.0 82.0 82.0 112.0 18:43:06 INFO - PROCESS | 13122 | 18:43:06 INFO - PROCESS | 13122 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 18:43:06 INFO - PROCESS | 13122 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 117.0 118.0 118.0 117.0 18:43:06 INFO - PROCESS | 13122 | 18:43:06 INFO - PROCESS | 13122 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 18:43:06 INFO - PROCESS | 13122 | Values: 146.0 147.0 146.0 147.0 146.0 146.0 147.0 147.0 147.0 148.0 18:43:06 INFO - PROCESS | 13122 | 18:43:06 INFO - PROCESS | 13122 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 18:43:06 INFO - PROCESS | 13122 | Values: 96.0 96.0 96.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 18:43:06 INFO - PROCESS | 13122 | 18:43:06 INFO - PROCESS | 13122 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:53.00 stddev:1.90 (3.6%) stddev-sans-first:1.92 18:43:06 INFO - PROCESS | 13122 | Values: 55.0 52.0 52.0 53.0 53.0 58.0 52.0 52.0 53.0 54.0 18:43:06 INFO - PROCESS | 13122 | 18:43:06 INFO - PROCESS | 13122 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:0.82 (1.3%) stddev-sans-first:0.83 18:43:06 INFO - PROCESS | 13122 | Values: 60.0 62.0 61.0 61.0 62.0 61.0 60.0 60.0 60.0 60.0 18:43:06 INFO - PROCESS | 13122 | 18:43:06 INFO - PROCESS | 13122 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:81.50 stddev:5.10 (6.3%) stddev-sans-first:4.99 18:43:06 INFO - PROCESS | 13122 | Values: 88.0 83.0 79.0 79.0 92.0 78.0 79.0 80.0 88.0 78.0 18:43:06 INFO - PROCESS | 13122 | 18:43:06 INFO - PROCESS | 13122 | [#11] stanford-crypto-ccm Cycles:10 Average:133.60 Median:131.00 stddev:16.11 (12.3%) stddev-sans-first:16.85 18:43:06 INFO - PROCESS | 13122 | Values: 126.0 140.0 123.0 127.0 131.0 124.0 124.0 133.0 177.0 131.0 18:43:06 INFO - PROCESS | 13122 | 18:43:06 INFO - PROCESS | 13122 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.00 Median:166.00 stddev:1.76 (1.1%) stddev-sans-first:1.83 18:43:06 INFO - PROCESS | 13122 | Values: 166.0 165.0 163.0 166.0 163.0 166.0 167.0 162.0 167.0 165.0 18:43:06 INFO - PROCESS | 13122 | 18:43:06 INFO - PROCESS | 13122 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:65.50 stddev:1.58 (2.4%) stddev-sans-first:1.66 18:43:06 INFO - PROCESS | 13122 | Values: 65.0 68.0 66.0 64.0 67.0 64.0 64.0 65.0 68.0 65.0 18:43:06 INFO - PROCESS | 13122 | -------- Summary: end -------- 18:43:06 INFO - PROCESS | 13122 | 18:43:07 INFO - TEST-INFO | 13122: exit 0 18:43:07 INFO - TEST-OK | kraken | took 61508ms 18:43:07 INFO - SUITE-END | took 1177s 18:43:07 INFO - Completed test suite (00:19:37) 18:43:07 INFO - javascript benchmark 18:43:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2994.2065352681543, 3013.6986301369852, 3018.6679465258817, 3046.5887105240786, 3064.4483992881273, 5130.410002849673, 5177.741112944356, 5201.271821944931, 5246.1606143017125, 5277.498637629419, 5143.202803565444, 5191.4548972357925, 5240.580753539717, 5245.0, 5258.605604579653, 4675.135100006492, 4742.549457801503, 4749.097671442415, 4769.809207631708, 4851.854444366657, 4806.495317991613, 4841.588464980481, 4846.660733748639, 4883.902321953558, 4900.921797204627, 4621.861344159681, 4648.976755116237, 4656.580907718321, 4825.613950883939, 4888.804447822101, 4709.670323077352, 4711.293306004092, 4711.882202944919, 4716.858494245143, 4735.668503204777, 4680.508546602592, 4699.835505757316, 4716.245400735866, 4746.02706445178, 4822.831200907986, 5237.188235823453, 5245.79016839326, 5258.421573626898, 5276.12943864262, 5311.840644780624, 5415.431379705114, 5462.808801691922, 5595.18869763882, 5597.916031259494, 5608.0, 5528.695921724304, 5578.44215578443, 5580.441955804427, 5592.664440133605, 5598.300212473441, 5187.974060129675, 5212.869678258036, 5213.218017297359, 5215.374155101412, 5275.155975043975, 5524.226608274845, 5569.498745112959, 5689.687067211343, 5689.9146512802345, 5696.430356964271, 5174.870628234249, 5419.620626556103, 5436.130219164915, 5465.398806131322, 5534.640248383842, 5487.122060470306, 5530.751116199781, 5533.723313834292, 5537.972310138504, 5539.086050801653, 5328.17413300939, 5528.612997090165, 5542.432849952626, 5551.8889622208135, 5609.8597535061135, 5391.272178255886, 5461.726913654381, 5509.889802203934, 5536.529395001389, 5639.548836093103, 4338.652907767371, 4342.34864770287, 4352.891177720519, 4388.27593447084, 4395.033092719596, 3861.0, 3868.5551161616772, 3889.3776995680555, 3894.8636797711943, 3924.941125883114, 5156.097682905476, 5211.42674305826, 5252.107141785906, 5281.55106815925, 5335.839924802262, 5583.162525621189, 5627.0, 5637.8590535236945, 5698.145278208219, 5700.9429905701245, 5301.310829592128, 5304.946950530522, 5305.787768489295, 5307.336582927134, 5308.097623404031, 4707.270373092108, 4796.208625576741, 4889.168841296988, 4892.437369702458, 4948.282499037619, 5713.74288157034, 5728.684922329312, 5730.971345143247, 5757.107648314518, 5828.0966450200285, 5545.694986775766, 5585.441455854545, 5593.049181639212, 5594.4125866785025, 5618.494335509824, 5490.6431081979545, 5737.483626473638, 5759.913601296068, 5760.33756118035, 5765.6540607562, 5320.44135365781, 5440.836774896759, 5461.699606521521, 5470.617056805985, 5548.223248745259, 5558.0, 5578.191162281365, 5578.972105139448, 5616.241807356118, 5620.494155525858, 5442.6462279951675, 5471.2887324647545, 5488.780448782004, 5494.917576236279, 5572.442755724395, 5322.627416080837, 5367.677939323653, 5420.864478388072, 5470.0, 5476.726163691879, 5453.918191227214, 5494.450554944633, 5494.862628434321, 5496.615236933376, 5554.611177217556, 5520.585956053232, 5533.474319939599, 5536.75084621201, 5539.972300138474, 5542.697703923657, 5240.292560504436, 5310.575153987595, 5336.332958380202, 5406.24312596229, 5464.098423760194], "value": 5147.538271626044, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.8220372572335, 581.3750218515096, 616.0051516800368, 633.4615576759754, 642.194046471678, 32593.67406325936, 42328.78835605821, 43056.56943430561, 43552.0, 43635.563644363545, 45471.0, 45742.0, 45765.31352029722, 45870.08259834801, 45904.770476147656, 8794.648214071429, 8934.374593778439, 8938.0, 8942.955285223565, 8949.373543851932, 8799.692010779623, 8860.955695221515, 8875.644974201025, 8883.156100170505, 8888.466691998501, 8914.242289405409, 8928.642854285821, 8947.105289471066, 8955.552222388887, 8962.148595883413, 8881.111888811132, 8917.0, 8921.509316987564, 8926.776830579223, 8939.106089391042, 8820.382573219877, 8914.687985920527, 8915.375923685344, 8920.0, 8922.821543569156, 42167.78916105431, 42178.156436871395, 42302.36546451806, 42506.57493425088, 42624.57375426237, 3258.152880251128, 3513.402721537345, 3525.7708248963736, 3535.169235229719, 3812.3137835189655, 31289.8435507821, 31413.214669633213, 31826.0, 32158.839205804055, 33132.503012454836, 4335.5014173370155, 4387.5393083726385, 4392.978035109804, 4401.5598440156045, 4476.61948734358, 332478.0, 334691.0, 335571.0, 337559.0, 338164.0, 55770.72114639401, 56035.15947260794, 56086.71956640191, 56096.43903560994, 56306.43693563012, 50875.236871446956, 52716.20925686118, 55895.0, 58274.41725582775, 58439.70780146072, 17039.062851543284, 17229.65540689179, 17232.052237126827, 17245.22396492161, 17245.741313880302, 13472.0, 13563.186208827501, 13578.0, 13601.183928964294, 13605.455781768618, 13928.37322320498, 14351.928240358731, 15089.0, 15723.21383930799, 15751.291191896393, 6543.928455447067, 6671.666416679147, 6768.289329620417, 6780.457563395015, 6787.966060169668, 948.3077353531822, 1005.7183988483237, 1034.4052170002278, 1048.3657387280584, 1106.5186643809807, 30677.386452270828, 30881.0, 31601.0, 31690.841545792584, 31770.841145794584, 1047.512906498482, 1110.3393480878865, 1156.5200441816553, 1166.1370585766472, 1169.473736818435, 15419.920605557727, 16592.502224933272, 16638.417655382003, 16642.3343066276, 16835.663286734198, 518491.0, 519526.0, 521182.0, 522254.0, 522326.0, 57451.42548574544, 57612.711936440886, 57619.0, 57673.42326576765, 57730.0, 1296.293520031585, 1300.90243231758, 1324.43711422645, 1325.549313233486, 1330.733853229358, 29360.41279174447, 31034.0, 31060.068197954097, 31137.844310778302, 31331.37337253288, 50668.746656266485, 50886.49113508966, 51091.23363149481, 51146.74426627992, 51151.48848511467, 355883.0, 356853.0, 356914.0, 357512.0, 359036.0, 32536.34927301488, 33504.822186557794, 39975.400368993905, 40314.348132557796, 40532.1893562133, 45781.31328030149, 46835.29747053729, 46835.29747053729, 47196.05607887754, 47224.527754723385, 39539.97591392786, 39650.2069958605, 39702.20595588014, 40461.0, 41259.587404126774, 40004.0, 40120.562625586164, 40304.1939161221, 40627.59372406356, 41797.16405671809, 36907.815460922524, 39325.0, 40104.0, 40144.39783403193, 40302.39546406748, 34180.31639367248, 35510.46734298936, 35987.64012359843, 36445.58085393247, 36665.45001825028, 27138.457230854878, 27173.184804455897, 27340.316492087855, 27498.862505687342, 27513.44973100567], "value": 19796.8584586669, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.65320864430646, 391.44219487230697, 391.79039214020503, 393.81293885404426, 411.4671500406973, 14019.0, 16369.181540922966, 18198.72701909471, 19649.410517684475, 19696.21215151394, 16127.596810079755, 17222.13889305536, 18333.7249941251, 18787.43637690868, 19000.714989275137, 5533.363663178746, 5637.605367624268, 5751.626144300607, 5792.82621521355, 5887.381824908387, 3827.8468861245515, 5796.217510636074, 5829.650220986754, 5832.096025116092, 5835.474807267345, 4020.5778393268724, 5576.386597474275, 5793.594448388614, 5812.3025236971625, 5908.438698323674, 5664.688442135681, 5888.852778680546, 5895.528357731393, 5899.705014749266, 5913.172155898178, 5808.59339846211, 5808.854778630526, 5812.041013232812, 5815.941840581625, 5816.970915145397, 13055.804162937564, 21999.780002199932, 22371.32886013422, 22645.433864153365, 22802.885985569967, 2253.1550668499312, 2279.7378301495373, 2281.0, 2342.0865862313713, 2451.0563433078214, 9843.114119729187, 9998.0, 10311.639092631796, 11269.267497612711, 14365.425382984668, 1887.3488646416963, 1932.5072106612724, 1968.9704654430195, 1984.781674015857, 1985.414302780683, 80289.59855200745, 80958.5952070236, 81203.5939820303, 82154.71381144747, 84415.0, 10659.786804263871, 10800.0, 10802.51388687511, 10971.396573188551, 11130.554777808959, 13331.60005199826, 15630.687386252212, 15641.921790390976, 15642.530724078295, 15647.374105035671, 7114.57312561248, 8001.639926203335, 8093.473924194908, 8146.389020823462, 8239.588020598947, 7915.9208407915185, 7925.801854953672, 8042.437029408003, 8209.630566624397, 8216.465929714668, 4661.580457758818, 4749.382580264612, 4817.6539136676765, 4860.78126484302, 4887.193613053877, 1937.7715627029029, 1943.5335519475225, 1995.2019192322896, 2017.459546765223, 2025.6455120353878, 838.2120806441925, 895.2703546609623, 927.3601215161517, 974.4250891973769, 991.2961797124123, 11340.979311861973, 11770.293782373084, 17123.400680976105, 17328.133593320283, 18803.717944230848, 459.8758335249464, 469.53281484922036, 478.91618966680693, 490.5070404243712, 493.2305603258928, 8862.335324850534, 9973.750656233653, 10114.342567733074, 10254.48727563619, 10506.947465262625, 458416.0, 463246.0, 463677.0, 472007.0, 475438.0, 86702.0, 86923.52305907819, 87152.0, 93693.0, 96529.51735241279, 471.48608017262035, 483.3450674336224, 499.6003197442104, 499.7551199912017, 501.59120316942307, 10100.696979090639, 10637.734056648645, 10643.308184967953, 10832.566697332019, 11099.500522476346, 40999.0, 41860.58139418567, 42437.0, 42457.15085698207, 42773.14453710971, 51137.48862511327, 56645.43354566402, 57475.42524574701, 57523.7123814395, 57760.0, 5864.266966629171, 8312.459690120122, 8486.83026339482, 8521.190486903733, 8715.0, 7924.920750792418, 11247.718807029562, 12118.848709372596, 12245.75508489843, 12628.873711263137, 9899.059589339002, 11127.221094523306, 11551.191416600757, 11609.825852612048, 11792.29246245228, 10875.184361172785, 10905.34567925927, 11292.943535282271, 11539.423028848692, 11662.941685291858, 11566.884331156918, 11770.293782373084, 11904.702382440508, 11988.880111198776, 12008.159428839897, 8485.236328730443, 8491.19333663301, 8795.560221988748, 8796.736097917073, 9130.223930965676, 10612.575496980035, 11378.658640240807, 11568.305901645928, 11598.652040438801, 11753.823692644446], "value": 8498.036910318187, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1297.7534268488992, 1465.428482891672, 1480.21548579253, 1588.1900230882254, 1720.5224476753474, 7518.624068796559, 8806.955965220173, 9109.45343279403, 9143.588538515765, 9393.342466027381, 9216.032316606761, 9283.257339412849, 9293.860592091123, 9294.117058879412, 9301.488418137, 2301.631738921769, 2327.104064935004, 2330.3009097270838, 2331.8484298520625, 2335.381124002141, 2270.182734215681, 2325.244295603927, 2407.987960060197, 2409.891554880026, 2411.867347295898, 2312.7687231276905, 2320.071971211512, 2326.9883650581723, 2335.1243283768586, 2342.824288178385, 2304.34326217029, 2330.2892617751577, 2331.568659797943, 2334.26470661741, 2345.624700048001, 2317.142657216824, 2327.1622216002224, 2331.6968794056834, 2334.4397344637337, 2338.2166974063707, 8600.311975041981, 8891.33315001371, 9142.862857057149, 9208.585613647401, 9209.447433154031, 5342.679439233659, 5482.835514934558, 5487.42382049883, 5491.066518691832, 5494.066008778517, 3482.7562070655063, 3529.8941031769086, 3542.5926018507944, 3556.982215088934, 3610.2598967211657, 1107.5016242690822, 1127.870294916087, 1128.5147386623748, 1139.0545846947098, 1144.3648774929911, 12599.622011339674, 12624.116311858174, 12666.87333126666, 12674.239545627384, 12693.365331733468, 4421.226285400042, 4587.357769912215, 4663.860084197479, 4707.505711900201, 4807.302941073594, 9468.857967130498, 9477.194438472807, 9481.66814161501, 9482.857757133648, 9488.620455181854, 5232.869178270574, 5242.397124330751, 5242.842714718565, 5245.632805703564, 5246.658967167198, 4270.508891477458, 4291.6137547620865, 4426.490953540319, 4910.90178196434, 4977.352944117314, 3780.3951367781024, 3907.7459965102175, 3983.2630963271886, 3996.960030399659, 4015.3575427931974, 1132.5300000499865, 1150.8216226484908, 1185.1289302362757, 1185.3006726031683, 1189.41718557906, 796.7609717084852, 877.9648814047366, 891.4116682989196, 910.5583791860943, 922.1792604581927, 5753.252077229933, 5860.179574859523, 5871.94128058714, 5940.405959404025, 5948.524118070631, 851.7572491839796, 891.0332289466002, 920.4339331311329, 954.8949615542285, 992.2359782967075, 3835.290471262825, 3876.4960555127655, 3936.0, 3942.7634341939574, 4031.6169963853386, 10809.405482698527, 11224.551017959353, 11249.156313276537, 11365.204435689588, 11366.602168924213, 11241.94379028116, 11262.662120136409, 11265.831012534818, 11274.887251127384, 11292.435378231055, 8296.0, 8345.374096942754, 8743.51910644908, 8751.431156974904, 8764.737057888273, 5600.81568188415, 5878.911816322673, 5927.081302398135, 6030.095485677008, 6102.633841969496, 10208.540615672164, 10313.845292320471, 10321.587136514456, 10338.689839304832, 10445.164386848883, 10140.949295253771, 10605.310654807412, 10692.62575809843, 10722.463876805972, 10736.89263107359, 6951.617661028692, 7136.6788494518905, 7783.92216077832, 8086.5148091114725, 8237.629306681094, 8687.522186279815, 9041.18629323364, 9073.818523629358, 9131.497767622845, 9146.634134634805, 7591.8861217080685, 7735.497192682457, 7741.225877412214, 7853.09689385728, 7879.763607091796, 7389.778306650809, 7580.128285247267, 7610.505317154589, 7667.386609071149, 7803.180666029985, 7265.7093716252875, 7374.373178279906, 7377.926220737724, 7387.261273872569, 7395.371393431618, 5015.147424937696, 5031.0, 5112.795488180431, 5118.641695081308, 5225.6603320784025, 5024.120778863758, 5024.924626130538, 5093.286939828501, 5156.56169225605, 5158.4583618721], "value": 4648.473528476117, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.56875667795043, 306.1382209081436, 311.90642807157855, 313.55944897419135, 316.56788483719714, 5105.872353191172, 5264.763085661145, 5286.8413947581585, 5348.251244825723, 5349.8127565535215, 5138.280640710294, 5239.0, 5270.683758974455, 5271.525562699357, 5273.235380869772, 4110.362893751473, 4125.113100683352, 4136.172765446908, 4138.772367519785, 4138.937915931264, 3951.604839516054, 4087.305158123126, 4110.0, 4110.753354798721, 4157.750534967897, 4086.7126855040715, 4088.6115818997146, 4094.6928980326447, 4100.1594673092095, 4110.568390319018, 4076.857309994151, 4080.775557344345, 4099.221147981874, 4115.34154535273, 4118.464599602063, 3595.0, 3599.748017638766, 3604.1530240393486, 3621.2938476996997, 3630.0, 5115.462876397962, 5138.7173705446185, 5183.948160518385, 5186.7147306898105, 5209.687418754849, 4662.743549104832, 4671.299305104228, 4685.718856868565, 4689.906201875978, 4700.824793801549, 5512.972435137839, 5514.393416724157, 5514.558835293167, 5556.805062000528, 5578.972105139448, 3698.6486283802997, 3850.942235866464, 3865.632764887331, 3870.0518372998513, 3884.8057597120314, 5734.39788822176, 5766.481016708516, 5774.393688662672, 5778.479936805666, 5779.508741756914, 3980.283548961157, 4008.178323443687, 4045.1505183911117, 4045.959540404617, 4051.149258655715, 3916.2559113768293, 3989.9202015959518, 3999.7400168988925, 4017.7187596868525, 4087.2029954159248, 4620.699654522446, 4628.213203755369, 4634.328022436728, 4638.5593368629925, 4662.417197850269, 5641.351244606841, 5644.57665675076, 5647.604667673223, 5653.321601407775, 5672.319321681342, 1321.6717199214727, 1359.157322460081, 1362.8500864904852, 1393.3451277899371, 1407.936642851074, 925.9444433334022, 931.329442801182, 933.7338858425317, 955.3360414511986, 963.0658261486348, 5292.44429334922, 5306.92039619406, 5322.414534401213, 5328.641196494869, 5342.2253773202665, 5587.69267690281, 5601.383847776741, 5624.578156638268, 5632.000639772904, 5634.60557760961, 5155.9742201288755, 5298.788048478018, 5321.0, 5353.625246232727, 5376.677399356051, 2646.087099950514, 2649.4701059787735, 2650.681918169832, 2678.8124831262016, 2703.5535988246193, 5206.947930520722, 5219.817306394334, 5221.564069880737, 5235.319408476874, 5271.182966640177, 4734.047070696008, 5046.192609182586, 5053.898922021539, 5082.923756143587, 5100.464451232641, 5100.413452452941, 5104.974475127675, 5118.25785261135, 5121.2574176744165, 5122.385313762373, 4890.266460031024, 4901.6323775716255, 4928.211486162197, 4988.9501104988485, 5020.974895125647, 4620.124731460148, 4820.734859582616, 4929.507049295042, 4957.785342591088, 4981.775820088033, 5113.207452844815, 5117.232415137759, 5132.6150538709, 5132.717700526507, 5178.6374953752875, 3627.3676845420196, 3630.4917311575873, 3645.76302540334, 3658.6158453363078, 3659.945100823543, 4778.211595086911, 4893.535114164149, 4969.35398398206, 5088.033273677989, 5357.794496238315, 5357.544608708304, 5412.621116521963, 5540.307461567304, 5548.9722551386985, 5568.192612071146, 5486.0, 5494.917576236279, 5503.2020357048805, 5567.582431317586, 5575.972120139373, 5331.333583302087, 5478.534324582455, 5524.779008839762, 5527.640703354269, 5546.528545073553, 5516.80691175823, 5547.140193270049, 5552.0, 5594.1608758686525, 5604.467575580314, 5377.677339359651, 5444.918326225189, 5465.535429488538, 5479.123340265538, 5492.286002819608], "value": 4073.4638214841057, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.2792027772922, 744.009339691711, 773.5822655765887, 787.6258777080888, 833.3791325462523, 16033.83966160338, 16657.583560410996, 16718.582035449104, 16759.0, 17081.316747330093, 16923.492295231164, 17082.231299591516, 17087.914560427213, 17101.40145094922, 17110.486685399428, 661.7419206509466, 677.701811203069, 800.0599295827394, 819.8442295963748, 823.2097186700775, 794.047143427886, 815.135955886759, 823.333100188846, 824.5382585751998, 825.0759149752286, 851.7700220940343, 860.0410542245382, 860.9698660546882, 861.1001503428931, 863.5466380150408, 685.5132855672479, 702.6381413572014, 856.567433446112, 857.8927634045745, 858.6436628799041, 601.0533409879457, 614.0788816774838, 619.2321521313584, 619.5477301569834, 619.6158381803266, 14741.55775326742, 14742.631434214123, 14786.482473113389, 14835.851641483556, 14916.776248356284, 13464.663383415394, 14037.368318425695, 14344.928275358556, 14383.208923509203, 14403.423863045466, 12982.221066736027, 13028.739425211537, 13138.014648901275, 13150.736985260337, 13151.60545183646, 3870.748401353931, 3900.161465284949, 4464.776761161961, 4523.728576285401, 4586.082783443291, 81459.0, 82986.0, 84992.0, 85130.0, 87115.56442217811, 10633.361998280128, 10763.408012559228, 10947.671569852917, 11132.387718675389, 11231.326120432801, 21779.0, 21812.236571719914, 21816.890915545322, 21817.67273490899, 21832.89083554572, 8361.95819020901, 8538.487690738451, 8801.647934082564, 8892.28861691076, 8956.552172391484, 4820.156472617278, 4924.630652701062, 4952.8761780955765, 4960.107180707435, 5078.4413714491375, 3408.880689175867, 3523.9647603523636, 3531.5055892175114, 3535.1338921964284, 3536.6463353664944, 578.7974209026806, 583.1981026089128, 584.333859400284, 585.1193953100642, 591.9792807251725, 625.4948929537175, 710.8009757267973, 721.2859269323333, 739.061392032127, 742.7474658615988, 10094.545745441474, 10263.846042309371, 10501.159907207406, 10863.239573229797, 11194.888051119548, 654.0320325917669, 671.4225765841372, 726.9745558905413, 731.8353370491596, 771.1902502372486, 4349.0, 4620.735839438651, 4646.442426908792, 4701.529847015271, 4712.293156026623, 96883.0, 115982.42008789902, 116608.0, 124598.0, 125267.0, 95449.0, 100526.0, 101748.49125754324, 104010.0, 106011.0, 89078.9999999987, 89256.75202735876, 89835.55082224678, 89960.0, 90770.54614727016, 9030.909690903007, 9148.771280718036, 9204.769880753034, 9330.486823224788, 9374.812503750023, 44628.77685611681, 51849.48150518598, 52182.47817521776, 52797.736011321234, 53205.73397132989, 68700.0, 69928.6503567479, 75761.62119189369, 75949.0, 78857.0, 12779.913707334981, 12881.935590322364, 12948.935255323662, 13362.398692058687, 13413.530526431528, 13199.934000329937, 13250.469981200644, 13368.398422070835, 13437.193768373929, 13655.931720341334, 13173.209607423585, 13451.394687238902, 14208.928955355157, 14313.64215894611, 14423.567292980808, 11633.883661163618, 11797.410129493663, 11971.521139154336, 12335.198212116184, 12424.937875310565, 12737.872621274038, 13833.792493112813, 14021.5092471763, 14274.857251427353, 15395.230238488255, 11733.237339572901, 11756.177067605186, 11798.292102473879, 11996.893234819905, 12011.279323240633, 12131.75736485283, 12231.877681223074, 12417.19288246261, 12588.244705317711, 12769.8084528734], "value": 7651.243526246294, "unit": "score"}], "name": "dromaeo_css", "value": 7075.564736509252, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 120.0, 111.0, 113.0, 112.0, 112.0, 111.0, 110.0, 112.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 122.0, 123.0, 157.0, 124.0, 118.0, 123.0, 119.0, 146.0, 118.0], "value": 129.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 163.0, 162.0, 162.0, 162.0, 162.0, 162.0, 162.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 75.0, 111.0, 75.0, 75.0, 76.0, 76.0, 114.0, 77.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 116.0, 83.0, 83.0, 83.0, 109.0, 82.0, 82.0, 112.0], "value": 91.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 147.0, 147.0, 147.0, 148.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 52.0, 53.0, 53.0, 58.0, 52.0, 52.0, 53.0, 54.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 61.0, 61.0, 62.0, 61.0, 60.0, 60.0, 60.0, 60.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 83.0, 79.0, 79.0, 92.0, 78.0, 79.0, 80.0, 88.0, 78.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 140.0, 123.0, 127.0, 131.0, 124.0, 124.0, 133.0, 177.0, 131.0], "value": 133.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 165.0, 163.0, 166.0, 163.0, 166.0, 167.0, 162.0, 167.0, 165.0], "value": 165.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 66.0, 64.0, 67.0, 64.0, 64.0, 65.0, 68.0, 65.0], "value": 65.6, "unit": "score"}], "name": "kraken", "value": 1498.3999999999999, "alertThreshold": 2.0}]} 18:43:07 INFO - Return code: 0 18:43:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:43:07 INFO - # TBPL SUCCESS # 18:43:07 INFO - Running post-action listener: _resource_record_post_action 18:43:07 INFO - [mozharness: 2016-09-22 01:43:07.929027Z] Finished run-tests step (success) 18:43:07 INFO - Running post-run listener: _resource_record_post_run 18:43:08 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 1748992; Write bytes: 408518656; Read time: 52; Write time: 270212 18:43:08 INFO - TinderboxPrint: CPU usage
13.1% 18:43:08 INFO - TinderboxPrint: I/O read bytes / time
1,748,992 / 52 18:43:08 INFO - TinderboxPrint: I/O write bytes / time
408,518,656 / 270,212 18:43:08 INFO - TinderboxPrint: CPU idle
8,288.3 (86.9%) 18:43:08 INFO - TinderboxPrint: CPU user
1,196.3 (12.5%) 18:43:08 INFO - TinderboxPrint: Swap in / out
0 / 0 18:43:08 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 120811520; Read time: 0; Write time: 89584 18:43:08 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287707136; Read time: 12; Write time: 180628 18:43:08 INFO - Running post-run listener: _upload_blobber_files 18:43:08 INFO - Blob upload gear active. 18:43:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:43:08 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 18:43:08 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'] 18:43:08 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 18:43:09 INFO - (blobuploader) - INFO - Open directory for files ... 18:43:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:43:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:43:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:43:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:43:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:43:13 INFO - (blobuploader) - INFO - Done attempting. 18:43:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:43:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:43:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:43:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:43:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:43:13 INFO - (blobuploader) - INFO - Done attempting. 18:43:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:43:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:43:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:43:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:43:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:43:14 INFO - (blobuploader) - INFO - Done attempting. 18:43:14 INFO - (blobuploader) - INFO - Iteration through files over. 18:43:14 INFO - Return code: 0 18:43:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:43:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:43:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c34d6d3309a205fb4161533f73a0b99d9ca62fcb19d06e9a67902c26ee98b5080a8ac62185d89c6d69bfeb242019703fa1e596e5004c1635fa45a71b41579127", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/740073ddb1a6595e76bdaa31aa0b23ffce7b7841a10b4c49fafc58c8f012928d68b313b785522292fa5f577823683ac973d08a39c3b1cab48320d24a4bdb4cea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3f8c47df449bc1cf914bba932adab1e75ed9fefb5eebba518c2a5e8bca37ae0efa60624dabdbfd749e397ff3deaa51ed0abeb45340fe73993eeb1e91a2038d46"} 18:43:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:43:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:43:14 INFO - Contents: 18:43:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c34d6d3309a205fb4161533f73a0b99d9ca62fcb19d06e9a67902c26ee98b5080a8ac62185d89c6d69bfeb242019703fa1e596e5004c1635fa45a71b41579127", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/740073ddb1a6595e76bdaa31aa0b23ffce7b7841a10b4c49fafc58c8f012928d68b313b785522292fa5f577823683ac973d08a39c3b1cab48320d24a4bdb4cea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3f8c47df449bc1cf914bba932adab1e75ed9fefb5eebba518c2a5e8bca37ae0efa60624dabdbfd749e397ff3deaa51ed0abeb45340fe73993eeb1e91a2038d46"} 18:43:14 INFO - Running post-run listener: copy_logs_to_upload_dir 18:43:14 INFO - Copying logs to upload dir... 18:43:14 INFO - mkdir: /builds/slave/test/build/upload/logs 18:43:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.044580 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-09-21 18:43:14.757433) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-21 18:43:14.760659) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1474505741.291732-1031377363 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/c34d6d3309a205fb4161533f73a0b99d9ca62fcb19d06e9a67902c26ee98b5080a8ac62185d89c6d69bfeb242019703fa1e596e5004c1635fa45a71b41579127", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/740073ddb1a6595e76bdaa31aa0b23ffce7b7841a10b4c49fafc58c8f012928d68b313b785522292fa5f577823683ac973d08a39c3b1cab48320d24a4bdb4cea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3f8c47df449bc1cf914bba932adab1e75ed9fefb5eebba518c2a5e8bca37ae0efa60624dabdbfd749e397ff3deaa51ed0abeb45340fe73993eeb1e91a2038d46"} build_url:https://queue.taskcluster.net/v1/task/AuVVSrCjQ8q-EFfV2bbuHg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011464 build_url: 'https://queue.taskcluster.net/v1/task/AuVVSrCjQ8q-EFfV2bbuHg/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/c34d6d3309a205fb4161533f73a0b99d9ca62fcb19d06e9a67902c26ee98b5080a8ac62185d89c6d69bfeb242019703fa1e596e5004c1635fa45a71b41579127", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/740073ddb1a6595e76bdaa31aa0b23ffce7b7841a10b4c49fafc58c8f012928d68b313b785522292fa5f577823683ac973d08a39c3b1cab48320d24a4bdb4cea", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3f8c47df449bc1cf914bba932adab1e75ed9fefb5eebba518c2a5e8bca37ae0efa60624dabdbfd749e397ff3deaa51ed0abeb45340fe73993eeb1e91a2038d46"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-21 18:43:14.787001) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 18:43:14.787439) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1474505741.291732-1031377363 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004427 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 18:43:14.872635) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-21 18:43:14.873016) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-21 18:43:14.873377) ========= ========= Total master_lag: 0.20 =========