builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-002 starttime: 1474668789.14 results: success (0) buildid: 20160923123106 builduid: 618bf223811346c089e4501d24ac8e07 revision: 76fd7dbb20d5387fe43dd30337b12f8ccb0bd30c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 15:13:09.138906) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 15:13:09.139418) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 15:13:09.139716) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 15:13:09.159573) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 15:13:09.159874) ========= 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=a0d2d2de893abaa8702a9954000001a7-1474668657.787450-1777339813 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-23 15:13:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.7M=0s 2016-09-23 15:13:09 (46.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.097081 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 15:13:09.287144) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 15:13:09.287457) ========= 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=a0d2d2de893abaa8702a9954000001a7-1474668657.787450-1777339813 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016903 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 15:13:09.351661) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 15:13:09.351971) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 76fd7dbb20d5387fe43dd30337b12f8ccb0bd30c --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 76fd7dbb20d5387fe43dd30337b12f8ccb0bd30c --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=a0d2d2de893abaa8702a9954000001a7-1474668657.787450-1777339813 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-23 15:13:09,859 truncating revision to first 12 chars 2016-09-23 15:13:09,860 Setting DEBUG logging. 2016-09-23 15:13:09,860 attempt 1/10 2016-09-23 15:13:09,860 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/76fd7dbb20d5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-23 15:13:10,432 unpacking tar archive at: fx-team-76fd7dbb20d5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.902001 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 15:13:10.278701) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 15:13:10.278991) ========= script_repo_revision: 76fd7dbb20d5387fe43dd30337b12f8ccb0bd30c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 15:13:10.279387) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 15:13:10.279712) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 15:13:10.288650) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-09-23 15:13:10.288917) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=a0d2d2de893abaa8702a9954000001a7-1474668657.787450-1777339813 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:13:10 INFO - MultiFileLogger online at 20160923 15:13:10 in /builds/slave/test 15:13:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 15:13:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:13:10 INFO - {'append_to_log': False, 15:13:10 INFO - 'base_work_dir': '/builds/slave/test', 15:13:10 INFO - 'blob_upload_branch': 'Fx-Team', 15:13:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:13:10 INFO - 'branch': 'Fx-Team', 15:13:10 INFO - 'buildbot_json_path': 'buildprops.json', 15:13:10 INFO - 'config_files': ('talos/linux_config.py',), 15:13:10 INFO - 'default_actions': ('clobber', 15:13:10 INFO - 'read-buildbot-config', 15:13:10 INFO - 'download-and-extract', 15:13:10 INFO - 'populate-webroot', 15:13:10 INFO - 'create-virtualenv', 15:13:10 INFO - 'install', 15:13:10 INFO - 'run-tests'), 15:13:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:13:10 INFO - 'download_minidump_stackwalk': True, 15:13:10 INFO - 'download_symbols': 'ondemand', 15:13:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:13:10 INFO - 'tooltool.py': '/tools/tooltool.py', 15:13:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:13:10 INFO - '/tools/misc-python/virtualenv.py')}, 15:13:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:13:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:13:10 INFO - 'installer_path': 'installer.exe', 15:13:10 INFO - 'log_level': 'info', 15:13:10 INFO - 'log_name': 'talos', 15:13:10 INFO - 'log_to_console': True, 15:13:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:13:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:13:10 INFO - 'opt_config_files': (), 15:13:10 INFO - 'pip_index': False, 15:13:10 INFO - 'sps_profile': False, 15:13:10 INFO - 'sps_profile_interval': 0, 15:13:10 INFO - 'suite': 'dromaeojs-e10s', 15:13:10 INFO - 'system_bits': '32', 15:13:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:13:10 INFO - 'title': 'talos-linux64-ix-002', 15:13:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:13:10 INFO - 'use_talos_json': True, 15:13:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:13:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:13:10 INFO - 'work_dir': 'build'} 15:13:10 INFO - [mozharness: 2016-09-23 22:13:10.885121Z] Running clobber step. 15:13:10 INFO - Running pre-action listener: _resource_record_pre_action 15:13:10 INFO - Running main action method: clobber 15:13:10 INFO - rmtree: /builds/slave/test/build 15:13:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:13:11 INFO - Running post-action listener: _resource_record_post_action 15:13:11 INFO - [mozharness: 2016-09-23 22:13:11.874586Z] Finished clobber step (success) 15:13:11 INFO - [mozharness: 2016-09-23 22:13:11.874684Z] Running read-buildbot-config step. 15:13:11 INFO - Running pre-action listener: _resource_record_pre_action 15:13:11 INFO - Running main action method: read_buildbot_config 15:13:11 INFO - Using buildbot properties: 15:13:11 INFO - { 15:13:11 INFO - "project": "", 15:13:11 INFO - "product": "firefox", 15:13:11 INFO - "script_repo_revision": "production", 15:13:11 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 15:13:11 INFO - "repository": "", 15:13:11 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 15:13:11 INFO - "buildid": "20160923123106", 15:13:11 INFO - "pgo_build": "True", 15:13:11 INFO - "basedir": "/builds/slave/test", 15:13:11 INFO - "buildnumber": 1200, 15:13:11 INFO - "slavename": "talos-linux64-ix-002", 15:13:11 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:13:11 INFO - "platform": "ubuntu64_hw", 15:13:11 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 15:13:11 INFO - "branch": "fx-team", 15:13:11 INFO - "repo_path": "integration/fx-team", 15:13:11 INFO - "revision": "76fd7dbb20d5387fe43dd30337b12f8ccb0bd30c", 15:13:11 INFO - "stage_platform": "linux64-pgo", 15:13:11 INFO - "builduid": "618bf223811346c089e4501d24ac8e07", 15:13:11 INFO - "slavebuilddir": "test" 15:13:11 INFO - } 15:13:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/OTEjQE-xT-WQfasMLWtqeg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 15:13:11 INFO - Running post-action listener: _resource_record_post_action 15:13:11 INFO - [mozharness: 2016-09-23 22:13:11.877131Z] Finished read-buildbot-config step (success) 15:13:11 INFO - [mozharness: 2016-09-23 22:13:11.877221Z] Running download-and-extract step. 15:13:11 INFO - Running pre-action listener: _resource_record_pre_action 15:13:11 INFO - Running main action method: download_and_extract 15:13:11 INFO - mkdir: /builds/slave/test/build/tests 15:13:11 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')]} 15:13:11 INFO - trying https://queue.taskcluster.net/v1/task/OTEjQE-xT-WQfasMLWtqeg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:13:11 INFO - Downloading https://queue.taskcluster.net/v1/task/OTEjQE-xT-WQfasMLWtqeg/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 15:13:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OTEjQE-xT-WQfasMLWtqeg/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 15:13:12 INFO - Downloaded 1361 bytes. 15:13:12 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:13:12 INFO - Using the following test package requirements: 15:13:12 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:13:12 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:13:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:13:12 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:13:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:13:12 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:13:12 INFO - u'jsshell-linux-x86_64.zip'], 15:13:12 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:13:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:13:12 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:13:12 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:13:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:13:12 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:13:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:13:12 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:13:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:13:12 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:13:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:13:12 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:13:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OTEjQE-xT-WQfasMLWtqeg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:13:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OTEjQE-xT-WQfasMLWtqeg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:13:12 INFO - Fetch https://queue.taskcluster.net/v1/task/OTEjQE-xT-WQfasMLWtqeg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:13:13 INFO - Expected file size: 21948157 15:13:17 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 15:13:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OTEjQE-xT-WQfasMLWtqeg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:13:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OTEjQE-xT-WQfasMLWtqeg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:13:17 INFO - Fetch https://queue.taskcluster.net/v1/task/OTEjQE-xT-WQfasMLWtqeg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:13:17 INFO - Expected file size: 21948157 15:13:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OTEjQE-xT-WQfasMLWtqeg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 15:13:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OTEjQE-xT-WQfasMLWtqeg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:13:23 INFO - Fetch https://queue.taskcluster.net/v1/task/OTEjQE-xT-WQfasMLWtqeg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 15:13:23 INFO - Expected file size: 14414059 15:13:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:13:24 INFO - trying https://queue.taskcluster.net/v1/task/OTEjQE-xT-WQfasMLWtqeg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:13:24 INFO - Downloading https://queue.taskcluster.net/v1/task/OTEjQE-xT-WQfasMLWtqeg/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 15:13:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OTEjQE-xT-WQfasMLWtqeg/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 15:13:26 INFO - Downloaded 59702069 bytes. 15:13:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OTEjQE-xT-WQfasMLWtqeg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:13:26 INFO - mkdir: /builds/slave/test/properties 15:13:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:13:26 INFO - Writing to file /builds/slave/test/properties/build_url 15:13:26 INFO - Contents: 15:13:26 INFO - build_url:https://queue.taskcluster.net/v1/task/OTEjQE-xT-WQfasMLWtqeg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:13:27 INFO - Running post-action listener: _resource_record_post_action 15:13:27 INFO - Running post-action listener: set_extra_try_arguments 15:13:27 INFO - [mozharness: 2016-09-23 22:13:27.185788Z] Finished download-and-extract step (success) 15:13:27 INFO - [mozharness: 2016-09-23 22:13:27.186016Z] Running populate-webroot step. 15:13:27 INFO - Running pre-action listener: _resource_record_pre_action 15:13:27 INFO - Running main action method: populate_webroot 15:13:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:13:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:13:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:13:27 INFO - '--tppagecycles', 15:13:27 INFO - '7'], 15:13:27 INFO - 'tests': ['tsvgm']}}, 15:13:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:13:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:13:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:13:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:13:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:13:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:13:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:27 INFO - 'talos_options': ['--disable-e10s'], 15:13:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:13:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:13:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:27 INFO - 'talos_options': ['--disable-e10s'], 15:13:27 INFO - 'tests': ['damp', 'tps']}, 15:13:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:27 INFO - 'tests': ['damp', 'tps']}, 15:13:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:13:27 INFO - 'tests': ['dromaeo_dom']}, 15:13:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:13:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:13:27 INFO - 'tests': ['basic_compositor_video']}, 15:13:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:13:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:13:27 INFO - 'tests': ['a11yr', 15:13:27 INFO - 'ts_paint', 15:13:27 INFO - 'tpaint', 15:13:27 INFO - 'sessionrestore', 15:13:27 INFO - 'sessionrestore_no_auto_restore', 15:13:27 INFO - 'tabpaint']}, 15:13:27 INFO - 'other-e10s': {'tests': ['a11yr', 15:13:27 INFO - 'ts_paint', 15:13:27 INFO - 'tpaint', 15:13:27 INFO - 'sessionrestore', 15:13:27 INFO - 'sessionrestore_no_auto_restore', 15:13:27 INFO - 'tabpaint']}, 15:13:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:13:27 INFO - 'ts_paint', 15:13:27 INFO - 'tpaint', 15:13:27 INFO - 'sessionrestore', 15:13:27 INFO - 'sessionrestore_no_auto_restore', 15:13:27 INFO - 'tabpaint']}, 15:13:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:13:27 INFO - 'ts_paint', 15:13:27 INFO - 'tpaint', 15:13:27 INFO - 'sessionrestore', 15:13:27 INFO - 'sessionrestore_no_auto_restore', 15:13:27 INFO - 'tabpaint']}, 15:13:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:13:27 INFO - 'tests': ['a11yr', 15:13:27 INFO - 'ts_paint', 15:13:27 INFO - 'tpaint', 15:13:27 INFO - 'sessionrestore', 15:13:27 INFO - 'sessionrestore_no_auto_restore', 15:13:27 INFO - 'tabpaint']}, 15:13:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:13:27 INFO - 'tests': ['a11yr', 15:13:27 INFO - 'ts_paint', 15:13:27 INFO - 'tpaint', 15:13:27 INFO - 'sessionrestore', 15:13:27 INFO - 'sessionrestore_no_auto_restore', 15:13:27 INFO - 'tabpaint']}, 15:13:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:13:27 INFO - 'tests': ['tsvgx', 15:13:27 INFO - 'tsvgr_opacity', 15:13:27 INFO - 'tart', 15:13:27 INFO - 'tscrollx', 15:13:27 INFO - 'cart']}, 15:13:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:13:27 INFO - 'tsvgr_opacity', 15:13:27 INFO - 'tart', 15:13:27 INFO - 'tscrollx', 15:13:27 INFO - 'cart']}, 15:13:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:27 INFO - 'talos_options': ['--disable-e10s'], 15:13:27 INFO - 'tests': ['tp5o']}, 15:13:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:27 INFO - 'tests': ['tp5o']}, 15:13:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:27 INFO - 'talos_options': ['--disable-e10s', 15:13:27 INFO - '--xperf_path', 15:13:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:13:27 INFO - 'tests': ['tp5n']}, 15:13:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:27 INFO - 'talos_options': ['--xperf_path', 15:13:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:13:27 INFO - 'tests': ['tp5n']}}, 15:13:27 INFO - 'talos.zip': {'path': '', 15:13:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:13:27 INFO - Running post-action listener: _resource_record_post_action 15:13:27 INFO - [mozharness: 2016-09-23 22:13:27.202440Z] Finished populate-webroot step (success) 15:13:27 INFO - [mozharness: 2016-09-23 22:13:27.202529Z] Running create-virtualenv step. 15:13:27 INFO - Running pre-action listener: _resource_record_pre_action 15:13:27 INFO - Running main action method: create_virtualenv 15:13:27 INFO - Creating virtualenv /builds/slave/test/build/venv 15:13:27 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 15:13:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:13:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:13:27 INFO - Using real prefix '/usr' 15:13:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:13:27 INFO - Installing distribute.............................................................................................................................................................................................done. 15:13:29 INFO - Installing pip.................done. 15:13:29 INFO - Return code: 0 15:13:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:13: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')]} 15:13:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13: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')]} 15:13:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:29 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 0x7f8ace7edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ca7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1159790>, '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 0x115a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115ab20>, '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': 'a0d2d2de893abaa8702a9954000001a7-1474668657.787450-1777339813', '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 15:13:29 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 15:13:29 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 15:13:29 INFO - Using env: {'DISPLAY': ':0', 15:13:29 INFO - 'HOME': '/home/cltbld', 15:13:29 INFO - 'LANG': 'en_US.UTF-8', 15:13:29 INFO - 'LANGUAGE': 'en_US:en', 15:13:29 INFO - 'LOGNAME': 'cltbld', 15:13:29 INFO - 'MAIL': '/var/mail/cltbld', 15:13:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:29 INFO - 'MOZ_NO_REMOTE': '1', 15:13:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:29 INFO - 'NO_EM_RESTART': '1', 15:13:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:29 INFO - 'PWD': '/builds/slave/test', 15:13:29 INFO - 'SHELL': '/bin/bash', 15:13:29 INFO - 'SHLVL': '1', 15:13:29 INFO - 'TERM': 'linux', 15:13:29 INFO - 'TMOUT': '86400', 15:13:29 INFO - 'USER': 'cltbld', 15:13:29 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1474668657.787450-1777339813', 15:13:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:29 INFO - '_': '/tools/buildbot/bin/python'} 15:13:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:29 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 15:13:29 INFO - Cleaning up... 15:13:29 INFO - Return code: 0 15:13:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:13: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')]} 15:13:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13: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')]} 15:13:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:29 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 0x7f8ace7edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ca7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1159790>, '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 0x115a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115ab20>, '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': 'a0d2d2de893abaa8702a9954000001a7-1474668657.787450-1777339813', '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 15:13:29 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 15:13:29 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 15:13:29 INFO - Using env: {'DISPLAY': ':0', 15:13:29 INFO - 'HOME': '/home/cltbld', 15:13:29 INFO - 'LANG': 'en_US.UTF-8', 15:13:29 INFO - 'LANGUAGE': 'en_US:en', 15:13:29 INFO - 'LOGNAME': 'cltbld', 15:13:29 INFO - 'MAIL': '/var/mail/cltbld', 15:13:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:30 INFO - 'MOZ_NO_REMOTE': '1', 15:13:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:30 INFO - 'NO_EM_RESTART': '1', 15:13:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:30 INFO - 'PWD': '/builds/slave/test', 15:13:30 INFO - 'SHELL': '/bin/bash', 15:13:30 INFO - 'SHLVL': '1', 15:13:30 INFO - 'TERM': 'linux', 15:13:30 INFO - 'TMOUT': '86400', 15:13:30 INFO - 'USER': 'cltbld', 15:13:30 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1474668657.787450-1777339813', 15:13:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:30 INFO - '_': '/tools/buildbot/bin/python'} 15:13:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:30 INFO - Downloading/unpacking psutil>=3.1.1 15:13:30 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 15:13:30 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 15:13:30 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 15:13:30 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 15:13:30 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 15:13:30 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 15:13:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:13:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:13:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:13:32 INFO - Installing collected packages: psutil 15:13:32 INFO - Running setup.py install for psutil 15:13:32 INFO - building 'psutil._psutil_linux' extension 15:13:32 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 15:13:32 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 15:13:32 INFO - building 'psutil._psutil_posix' extension 15:13:32 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 15:13:32 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 15:13:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:13:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:13:32 INFO - Successfully installed psutil 15:13:32 INFO - Cleaning up... 15:13:32 INFO - Return code: 0 15:13:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:13:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:13:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ace7edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ca7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1159790>, '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 0x115a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115ab20>, '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': 'a0d2d2de893abaa8702a9954000001a7-1474668657.787450-1777339813', '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 15:13:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:13:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:13:32 INFO - Using env: {'DISPLAY': ':0', 15:13:32 INFO - 'HOME': '/home/cltbld', 15:13:32 INFO - 'LANG': 'en_US.UTF-8', 15:13:32 INFO - 'LANGUAGE': 'en_US:en', 15:13:32 INFO - 'LOGNAME': 'cltbld', 15:13:32 INFO - 'MAIL': '/var/mail/cltbld', 15:13:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:32 INFO - 'MOZ_NO_REMOTE': '1', 15:13:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:32 INFO - 'NO_EM_RESTART': '1', 15:13:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:32 INFO - 'PWD': '/builds/slave/test', 15:13:32 INFO - 'SHELL': '/bin/bash', 15:13:32 INFO - 'SHLVL': '1', 15:13:32 INFO - 'TERM': 'linux', 15:13:32 INFO - 'TMOUT': '86400', 15:13:32 INFO - 'USER': 'cltbld', 15:13:32 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1474668657.787450-1777339813', 15:13:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:32 INFO - '_': '/tools/buildbot/bin/python'} 15:13:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:13:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:13:34 INFO - Installing collected packages: mozsystemmonitor 15:13:34 INFO - Running setup.py install for mozsystemmonitor 15:13:35 INFO - Successfully installed mozsystemmonitor 15:13:35 INFO - Cleaning up... 15:13:35 INFO - Return code: 0 15:13:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:13:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:13:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8ace7edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ca7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1159790>, '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 0x115a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115ab20>, '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': 'a0d2d2de893abaa8702a9954000001a7-1474668657.787450-1777339813', '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 15:13:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:13:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:13:35 INFO - Using env: {'DISPLAY': ':0', 15:13:35 INFO - 'HOME': '/home/cltbld', 15:13:35 INFO - 'LANG': 'en_US.UTF-8', 15:13:35 INFO - 'LANGUAGE': 'en_US:en', 15:13:35 INFO - 'LOGNAME': 'cltbld', 15:13:35 INFO - 'MAIL': '/var/mail/cltbld', 15:13:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:35 INFO - 'MOZ_NO_REMOTE': '1', 15:13:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:35 INFO - 'NO_EM_RESTART': '1', 15:13:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:35 INFO - 'PWD': '/builds/slave/test', 15:13:35 INFO - 'SHELL': '/bin/bash', 15:13:35 INFO - 'SHLVL': '1', 15:13:35 INFO - 'TERM': 'linux', 15:13:35 INFO - 'TMOUT': '86400', 15:13:35 INFO - 'USER': 'cltbld', 15:13:35 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1474668657.787450-1777339813', 15:13:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:35 INFO - '_': '/tools/buildbot/bin/python'} 15:13:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:35 INFO - Downloading/unpacking jsonschema==2.5.1 15:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:13:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:37 INFO - Downloading functools32-3.2.3-2.tar.gz 15:13:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:13:37 INFO - warning: no files found matching '*.txt' 15:13:37 INFO - no previously-included directories found matching 'build' 15:13:37 INFO - no previously-included directories found matching 'dist' 15:13:37 INFO - no previously-included directories found matching '.git*' 15:13:37 INFO - Installing collected packages: jsonschema, functools32 15:13:37 INFO - Running setup.py install for functools32 15:13:37 INFO - warning: no files found matching '*.txt' 15:13:37 INFO - no previously-included directories found matching 'build' 15:13:37 INFO - no previously-included directories found matching 'dist' 15:13:37 INFO - no previously-included directories found matching '.git*' 15:13:37 INFO - Successfully installed jsonschema functools32 15:13:37 INFO - Cleaning up... 15:13:37 INFO - Return code: 0 15:13:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:13:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:13:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8ace7edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ca7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1159790>, '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 0x115a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115ab20>, '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': 'a0d2d2de893abaa8702a9954000001a7-1474668657.787450-1777339813', '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 15:13:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:13:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:13:37 INFO - Using env: {'DISPLAY': ':0', 15:13:37 INFO - 'HOME': '/home/cltbld', 15:13:37 INFO - 'LANG': 'en_US.UTF-8', 15:13:37 INFO - 'LANGUAGE': 'en_US:en', 15:13:37 INFO - 'LOGNAME': 'cltbld', 15:13:37 INFO - 'MAIL': '/var/mail/cltbld', 15:13:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:37 INFO - 'MOZ_NO_REMOTE': '1', 15:13:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:37 INFO - 'NO_EM_RESTART': '1', 15:13:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:37 INFO - 'PWD': '/builds/slave/test', 15:13:37 INFO - 'SHELL': '/bin/bash', 15:13:37 INFO - 'SHLVL': '1', 15:13:37 INFO - 'TERM': 'linux', 15:13:37 INFO - 'TMOUT': '86400', 15:13:37 INFO - 'USER': 'cltbld', 15:13:37 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1474668657.787450-1777339813', 15:13:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:37 INFO - '_': '/tools/buildbot/bin/python'} 15:13:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:13:37 INFO - Cleaning up... 15:13:37 INFO - Return code: 0 15:13:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:13:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:13:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8ace7edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ca7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1159790>, '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 0x115a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115ab20>, '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': 'a0d2d2de893abaa8702a9954000001a7-1474668657.787450-1777339813', '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 15:13:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:13:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:13:37 INFO - Using env: {'DISPLAY': ':0', 15:13:37 INFO - 'HOME': '/home/cltbld', 15:13:37 INFO - 'LANG': 'en_US.UTF-8', 15:13:37 INFO - 'LANGUAGE': 'en_US:en', 15:13:37 INFO - 'LOGNAME': 'cltbld', 15:13:37 INFO - 'MAIL': '/var/mail/cltbld', 15:13:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:37 INFO - 'MOZ_NO_REMOTE': '1', 15:13:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:37 INFO - 'NO_EM_RESTART': '1', 15:13:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:37 INFO - 'PWD': '/builds/slave/test', 15:13:37 INFO - 'SHELL': '/bin/bash', 15:13:37 INFO - 'SHLVL': '1', 15:13:37 INFO - 'TERM': 'linux', 15:13:37 INFO - 'TMOUT': '86400', 15:13:37 INFO - 'USER': 'cltbld', 15:13:37 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1474668657.787450-1777339813', 15:13:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:37 INFO - '_': '/tools/buildbot/bin/python'} 15:13:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:38 INFO - Downloading/unpacking blobuploader==1.2.4 15:13:38 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 15:13:38 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 15:13:38 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 15:13:38 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 15:13:38 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 15:13:38 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 15:13:39 INFO - Downloading blobuploader-1.2.4.tar.gz 15:13:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:13:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:13:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:13:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:13:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:40 INFO - Downloading docopt-0.6.1.tar.gz 15:13:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:13:40 INFO - Installing collected packages: blobuploader, requests, docopt 15:13:40 INFO - Running setup.py install for blobuploader 15:13:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:13:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:13:40 INFO - Running setup.py install for requests 15:13:41 INFO - Running setup.py install for docopt 15:13:41 INFO - Successfully installed blobuploader requests docopt 15:13:41 INFO - Cleaning up... 15:13:41 INFO - Return code: 0 15:13:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:13:41 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')]} 15:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:41 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')]} 15:13:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:41 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 0x7f8ace7edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ca7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1159790>, '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 0x115a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115ab20>, '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': 'a0d2d2de893abaa8702a9954000001a7-1474668657.787450-1777339813', '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 15:13:41 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 15:13:41 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 15:13:41 INFO - Using env: {'DISPLAY': ':0', 15:13:41 INFO - 'HOME': '/home/cltbld', 15:13:41 INFO - 'LANG': 'en_US.UTF-8', 15:13:41 INFO - 'LANGUAGE': 'en_US:en', 15:13:41 INFO - 'LOGNAME': 'cltbld', 15:13:41 INFO - 'MAIL': '/var/mail/cltbld', 15:13:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:41 INFO - 'MOZ_NO_REMOTE': '1', 15:13:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:41 INFO - 'NO_EM_RESTART': '1', 15:13:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:41 INFO - 'PWD': '/builds/slave/test', 15:13:41 INFO - 'SHELL': '/bin/bash', 15:13:41 INFO - 'SHLVL': '1', 15:13:41 INFO - 'TERM': 'linux', 15:13:41 INFO - 'TMOUT': '86400', 15:13:41 INFO - 'USER': 'cltbld', 15:13:41 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1474668657.787450-1777339813', 15:13:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:41 INFO - '_': '/tools/buildbot/bin/python'} 15:13:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:13:41 INFO - Running setup.py (path:/tmp/pip-IgiRcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:13:41 INFO - Running setup.py (path:/tmp/pip-We47e7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:13:41 INFO - Running setup.py (path:/tmp/pip-jWOL0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:13:41 INFO - Running setup.py (path:/tmp/pip-xIM_o7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:13:41 INFO - Running setup.py (path:/tmp/pip-ausoBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:13:41 INFO - Running setup.py (path:/tmp/pip-Kj4QZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:13:41 INFO - Running setup.py (path:/tmp/pip-DPnMKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:13:42 INFO - Running setup.py (path:/tmp/pip-2lZXL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:13:42 INFO - Running setup.py (path:/tmp/pip-mcChXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:13:42 INFO - Running setup.py (path:/tmp/pip-jah5YI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:13:42 INFO - Running setup.py (path:/tmp/pip-nK92uK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:13:42 INFO - Running setup.py (path:/tmp/pip-zQiALd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:13:42 INFO - Running setup.py (path:/tmp/pip-XoGFgR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:13:42 INFO - Running setup.py (path:/tmp/pip-rRoAIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:13:42 INFO - Running setup.py (path:/tmp/pip-wUeLZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:13:42 INFO - Running setup.py (path:/tmp/pip-6I1kf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:13:42 INFO - Running setup.py (path:/tmp/pip-V8kv4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:13:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:13:42 INFO - Running setup.py install for manifestparser 15:13:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:13:42 INFO - Running setup.py install for mozcrash 15:13:42 INFO - Running setup.py install for mozdebug 15:13:43 INFO - Running setup.py install for mozdevice 15:13:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:13:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:13:43 INFO - Running setup.py install for mozfile 15:13:43 INFO - Running setup.py install for mozhttpd 15:13:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:13:43 INFO - Running setup.py install for mozinfo 15:13:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:13:43 INFO - Running setup.py install for mozInstall 15:13:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:13:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:13:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:13:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:13:43 INFO - Running setup.py install for mozleak 15:13:43 INFO - Running setup.py install for mozlog 15:13:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:13:43 INFO - Running setup.py install for moznetwork 15:13:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:13:43 INFO - Running setup.py install for mozprocess 15:13:44 INFO - Running setup.py install for mozprofile 15:13:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:13:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:13:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:13:44 INFO - Running setup.py install for mozrunner 15:13:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:13:44 INFO - Running setup.py install for mozscreenshot 15:13:44 INFO - Running setup.py install for moztest 15:13:44 INFO - Running setup.py install for mozversion 15:13:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:13:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:13:44 INFO - Cleaning up... 15:13:44 INFO - Return code: 0 15:13:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:13:44 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')]} 15:13:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:44 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')]} 15:13:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:44 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 0x7f8ace7edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ca7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1159790>, '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 0x115a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115ab20>, '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': 'a0d2d2de893abaa8702a9954000001a7-1474668657.787450-1777339813', '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 15:13:44 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 15:13:44 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 15:13:44 INFO - Using env: {'DISPLAY': ':0', 15:13:44 INFO - 'HOME': '/home/cltbld', 15:13:44 INFO - 'LANG': 'en_US.UTF-8', 15:13:44 INFO - 'LANGUAGE': 'en_US:en', 15:13:44 INFO - 'LOGNAME': 'cltbld', 15:13:44 INFO - 'MAIL': '/var/mail/cltbld', 15:13:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:44 INFO - 'MOZ_NO_REMOTE': '1', 15:13:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:44 INFO - 'NO_EM_RESTART': '1', 15:13:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:44 INFO - 'PWD': '/builds/slave/test', 15:13:44 INFO - 'SHELL': '/bin/bash', 15:13:44 INFO - 'SHLVL': '1', 15:13:44 INFO - 'TERM': 'linux', 15:13:44 INFO - 'TMOUT': '86400', 15:13:44 INFO - 'USER': 'cltbld', 15:13:44 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1474668657.787450-1777339813', 15:13:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:44 INFO - '_': '/tools/buildbot/bin/python'} 15:13:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:13:44 INFO - Running setup.py (path:/tmp/pip-zILkkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:13:44 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)) 15:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:13:44 INFO - Running setup.py (path:/tmp/pip-YMnJvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:13:44 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)) 15:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:13:44 INFO - Running setup.py (path:/tmp/pip-JjSPIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:13:44 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)) 15:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:13:45 INFO - Running setup.py (path:/tmp/pip-RC6uRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:13:45 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)) 15:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:13:45 INFO - Running setup.py (path:/tmp/pip-3IeinE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:13:45 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)) 15:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:13:45 INFO - Running setup.py (path:/tmp/pip-ZL4asH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:13:45 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)) 15:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:13:45 INFO - Running setup.py (path:/tmp/pip-1xEF0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:13:45 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)) 15:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:13:45 INFO - Running setup.py (path:/tmp/pip-dkukNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:13:45 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)) 15:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:13:45 INFO - Running setup.py (path:/tmp/pip-F9aqd0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:13:45 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)) 15:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:13:45 INFO - Running setup.py (path:/tmp/pip-zX3VB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:13:45 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)) 15:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:13:45 INFO - Running setup.py (path:/tmp/pip-CKVgx3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:13:45 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)) 15:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:13:45 INFO - Running setup.py (path:/tmp/pip-MtFLXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:13:45 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)) 15:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:13:45 INFO - Running setup.py (path:/tmp/pip-_898Fz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:13:45 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)) 15:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:13:45 INFO - Running setup.py (path:/tmp/pip-gGCKMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:13:45 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)) 15:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:13:45 INFO - Running setup.py (path:/tmp/pip-TcSA5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:13:45 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)) 15:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:13:45 INFO - Running setup.py (path:/tmp/pip-qZWMw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:13:45 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)) 15:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:13:45 INFO - Running setup.py (path:/tmp/pip-JhLSfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:13:46 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)) 15:13:46 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)) 15:13:46 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)) 15:13:46 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)) 15:13:46 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)) 15:13:46 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)) 15:13:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:13:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:48 INFO - Downloading blessings-1.6.tar.gz 15:13:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:13:48 INFO - Installing collected packages: blessings 15:13:48 INFO - Running setup.py install for blessings 15:13:48 INFO - Successfully installed blessings 15:13:48 INFO - Cleaning up... 15:13:48 INFO - Return code: 0 15:13:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:13:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:13:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:13:48 INFO - Reading from file tmpfile_stdout 15:13:48 INFO - Current package versions: 15:13:48 INFO - argparse == 1.2.1 15:13:48 INFO - blessings == 1.6 15:13:48 INFO - blobuploader == 1.2.4 15:13:48 INFO - docopt == 0.6.1 15:13:48 INFO - functools32 == 3.2.3-2 15:13:48 INFO - jsonschema == 2.5.1 15:13:48 INFO - manifestparser == 1.1 15:13:48 INFO - mozInstall == 1.12 15:13:48 INFO - mozcrash == 0.17 15:13:48 INFO - mozdebug == 0.1 15:13:48 INFO - mozdevice == 0.48 15:13:48 INFO - mozfile == 1.2 15:13:48 INFO - mozhttpd == 0.7 15:13:48 INFO - mozinfo == 0.9 15:13:48 INFO - mozleak == 0.1 15:13:48 INFO - mozlog == 3.4 15:13:48 INFO - moznetwork == 0.27 15:13:48 INFO - mozprocess == 0.23 15:13:48 INFO - mozprofile == 0.28 15:13:48 INFO - mozrunner == 6.12 15:13:48 INFO - mozscreenshot == 0.1 15:13:48 INFO - mozsystemmonitor == 0.3 15:13:48 INFO - moztest == 0.7 15:13:48 INFO - mozversion == 1.4 15:13:48 INFO - psutil == 3.1.1 15:13:48 INFO - requests == 1.2.3 15:13:48 INFO - wsgiref == 0.1.2 15:13:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:13: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')]} 15:13:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13: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')]} 15:13:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:48 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 0x7f8ace7edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ca7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1159790>, '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 0x115a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115ab20>, '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': 'a0d2d2de893abaa8702a9954000001a7-1474668657.787450-1777339813', '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 15:13:48 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 15:13:48 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 15:13:48 INFO - Using env: {'DISPLAY': ':0', 15:13:48 INFO - 'HOME': '/home/cltbld', 15:13:48 INFO - 'LANG': 'en_US.UTF-8', 15:13:48 INFO - 'LANGUAGE': 'en_US:en', 15:13:48 INFO - 'LOGNAME': 'cltbld', 15:13:48 INFO - 'MAIL': '/var/mail/cltbld', 15:13:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:48 INFO - 'MOZ_NO_REMOTE': '1', 15:13:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:48 INFO - 'NO_EM_RESTART': '1', 15:13:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:48 INFO - 'PWD': '/builds/slave/test', 15:13:48 INFO - 'SHELL': '/bin/bash', 15:13:48 INFO - 'SHLVL': '1', 15:13:48 INFO - 'TERM': 'linux', 15:13:48 INFO - 'TMOUT': '86400', 15:13:48 INFO - 'USER': 'cltbld', 15:13:48 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1474668657.787450-1777339813', 15:13:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:48 INFO - '_': '/tools/buildbot/bin/python'} 15:13:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:48 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)) 15:13:48 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)) 15:13:48 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)) 15:13:48 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)) 15:13:48 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)) 15:13:48 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)) 15:13:48 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)) 15:13:48 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)) 15:13:48 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)) 15:13:48 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)) 15:13:48 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)) 15:13:48 INFO - Cleaning up... 15:13:48 INFO - Return code: 0 15:13:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:13: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')]} 15:13:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13: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')]} 15:13:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ace7edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ca7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1159790>, '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 0x115a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115ab20>, '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': 'a0d2d2de893abaa8702a9954000001a7-1474668657.787450-1777339813', '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 15:13:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:13:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:13:48 INFO - Using env: {'DISPLAY': ':0', 15:13:48 INFO - 'HOME': '/home/cltbld', 15:13:48 INFO - 'LANG': 'en_US.UTF-8', 15:13:48 INFO - 'LANGUAGE': 'en_US:en', 15:13:48 INFO - 'LOGNAME': 'cltbld', 15:13:48 INFO - 'MAIL': '/var/mail/cltbld', 15:13:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:48 INFO - 'MOZ_NO_REMOTE': '1', 15:13:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:48 INFO - 'NO_EM_RESTART': '1', 15:13:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:48 INFO - 'PWD': '/builds/slave/test', 15:13:48 INFO - 'SHELL': '/bin/bash', 15:13:48 INFO - 'SHLVL': '1', 15:13:48 INFO - 'TERM': 'linux', 15:13:48 INFO - 'TMOUT': '86400', 15:13:48 INFO - 'USER': 'cltbld', 15:13:48 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1474668657.787450-1777339813', 15:13:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:48 INFO - '_': '/tools/buildbot/bin/python'} 15:13:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:13:49 INFO - Cleaning up... 15:13:49 INFO - Return code: 0 15:13:49 INFO - Running post-action listener: _resource_record_post_action 15:13:49 INFO - Running post-action listener: _start_resource_monitoring 15:13:49 INFO - Starting resource monitoring. 15:13:49 INFO - [mozharness: 2016-09-23 22:13:49.058107Z] Finished create-virtualenv step (success) 15:13:49 INFO - [mozharness: 2016-09-23 22:13:49.058561Z] Running install step. 15:13:49 INFO - Running pre-action listener: _resource_record_pre_action 15:13:49 INFO - Running main action method: install 15:13:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:13:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:13:49 INFO - Reading from file tmpfile_stdout 15:13:49 INFO - Detecting whether we're running mozinstall >=1.0... 15:13:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:13:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:13:49 INFO - Reading from file tmpfile_stdout 15:13:49 INFO - Output received: 15:13:49 INFO - Usage: mozinstall [options] installer 15:13:49 INFO - Options: 15:13:49 INFO - -h, --help show this help message and exit 15:13:49 INFO - -d DEST, --destination=DEST 15:13:49 INFO - Directory to install application into. [default: 15:13:49 INFO - "/builds/slave/test"] 15:13:49 INFO - --app=APP Application being installed. [default: firefox] 15:13:49 INFO - mkdir: /builds/slave/test/build/application 15:13:49 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'] 15:13:49 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 15:14:06 INFO - Reading from file tmpfile_stdout 15:14:06 INFO - Output received: 15:14:06 INFO - /builds/slave/test/build/application/firefox/firefox 15:14:06 INFO - Running post-action listener: _resource_record_post_action 15:14:06 INFO - [mozharness: 2016-09-23 22:14:06.347895Z] Finished install step (success) 15:14:06 INFO - [mozharness: 2016-09-23 22:14:06.348139Z] Running run-tests step. 15:14:06 INFO - Running pre-action listener: _resource_record_pre_action 15:14:06 INFO - Running main action method: run_tests 15:14:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:14:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:14:06 INFO - Python 2.7.3 15:14:06 INFO - Return code: 0 15:14:06 INFO - grabbing minidump binary from tooltool 15:14:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:14:06 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 0x1159790>, '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 0x115a690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:14:06 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 15:14:06 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 15:14:06 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 15:14:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:14:06 INFO - Return code: 0 15:14:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:14:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:14:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:14:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:14:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:14:06 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OTEjQE-xT-WQfasMLWtqeg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:14:06 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OTEjQE-xT-WQfasMLWtqeg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:14:06 INFO - Using env: {'DISPLAY': ':0', 15:14:06 INFO - 'HOME': '/home/cltbld', 15:14:06 INFO - 'LANG': 'en_US.UTF-8', 15:14:06 INFO - 'LANGUAGE': 'en_US:en', 15:14:06 INFO - 'LOGNAME': 'cltbld', 15:14:06 INFO - 'MAIL': '/var/mail/cltbld', 15:14:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:14:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:14:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:06 INFO - 'MOZ_NO_REMOTE': '1', 15:14:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:14:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:06 INFO - 'NO_EM_RESTART': '1', 15:14:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:06 INFO - 'PWD': '/builds/slave/test', 15:14:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:14:06 INFO - 'SHELL': '/bin/bash', 15:14:06 INFO - 'SHLVL': '1', 15:14:06 INFO - 'TERM': 'linux', 15:14:06 INFO - 'TMOUT': '86400', 15:14:06 INFO - 'USER': 'cltbld', 15:14:06 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1474668657.787450-1777339813', 15:14:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:06 INFO - '_': '/tools/buildbot/bin/python'} 15:14:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OTEjQE-xT-WQfasMLWtqeg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:14:06 INFO - mozversion application_buildid: 20160923123106 15:14:06 INFO - mozversion application_changeset: 76fd7dbb20d5387fe43dd30337b12f8ccb0bd30c 15:14:06 INFO - mozversion application_display_name: Nightly 15:14:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:14:06 INFO - mozversion application_name: Firefox 15:14:06 INFO - mozversion application_remotingname: firefox 15:14:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:14:06 INFO - mozversion application_vendor: Mozilla 15:14:06 INFO - mozversion application_version: 52.0a1 15:14:06 INFO - mozversion platform_buildid: 20160923123106 15:14:06 INFO - mozversion platform_changeset: 76fd7dbb20d5387fe43dd30337b12f8ccb0bd30c 15:14:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:14:06 INFO - mozversion platform_version: 52.0a1 15:14:06 INFO - using testdate: 1474668846 15:14:06 INFO - actual date: 1474668846 15:14:06 INFO - starting webserver on 'localhost:48488' 15:14:06 INFO - SUITE-START | Running 2 tests 15:14:06 INFO - TEST-START | dromaeo_css 15:14:06 INFO - operating with platform_type : linux_ 15:14:06 INFO - Initialising browser for dromaeo_css test... 15:14:06 INFO - TEST-INFO | started process 20416 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmoAn4F/profile http://localhost:48488/getInfo.html) 15:14:11 INFO - PROCESS | 20416 | __metrics Screen width/height:1600/1200 15:14:11 INFO - PROCESS | 20416 | colorDepth:24 15:14:11 INFO - PROCESS | 20416 | Browser inner width/height: 1024/697 15:14:11 INFO - PROCESS | 20416 | __metrics 15:14:11 ERROR - PROCESS | 20416 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 15:14:12 INFO - TEST-INFO | 20416: exit 0 15:14:12 INFO - Browser initialized. 15:14:12 INFO - Running cycle 1/1 for dromaeo_css test... 15:14:12 INFO - TEST-INFO | started process 20539 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmoAn4F/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:14:25 INFO - PROCESS | 20539 | RSS: Main: 185159680 15:14:25 INFO - PROCESS | 20539 | 15:15:14 INFO - PROCESS | 20539 | 1474668914692 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] 15:17:24 INFO - PROCESS | 20539 | Cycle 1(1): loaded http://localhost:48488/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48488/tests/dromaeo/cssquery-ext.html) 15:17:25 INFO - PROCESS | 20539 | RSS: Main: 200355840 15:17:25 INFO - PROCESS | 20539 | 15:20:27 INFO - PROCESS | 20539 | Cycle 1(1): loaded http://localhost:48488/tests/dromaeo/cssquery-ext.html (next: http://localhost:48488/tests/dromaeo/cssquery-jquery.html) 15:20:28 INFO - PROCESS | 20539 | RSS: Main: 196898816 15:20:28 INFO - PROCESS | 20539 | 15:23:30 INFO - PROCESS | 20539 | Cycle 1(1): loaded http://localhost:48488/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48488/tests/dromaeo/cssquery-mootools.html) 15:23:31 INFO - PROCESS | 20539 | RSS: Main: 198795264 15:23:31 INFO - PROCESS | 20539 | 15:26:32 INFO - PROCESS | 20539 | Cycle 1(1): loaded http://localhost:48488/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48488/tests/dromaeo/cssquery-prototype.html) 15:26:33 INFO - PROCESS | 20539 | RSS: Main: 195194880 15:26:33 INFO - PROCESS | 20539 | 15:29:36 INFO - PROCESS | 20539 | Cycle 1(1): loaded http://localhost:48488/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48488/tests/dromaeo/cssquery-yui.html) 15:29:36 INFO - PROCESS | 20539 | RSS: Main: 198754304 15:29:36 INFO - PROCESS | 20539 | 15:32:39 INFO - PROCESS | 20539 | Cycle 1(1): loaded http://localhost:48488/tests/dromaeo/cssquery-yui.html (next: http://localhost:48488/tests/dromaeo/cssquery-dojo.html) 15:32:39 INFO - PROCESS | 20539 | RSS: Main: 199348224 15:32:39 INFO - PROCESS | 20539 | 15:32:39 INFO - PROCESS | 20539 | __start_tp_report 15:32:39 INFO - PROCESS | 20539 | _x_x_mozilla_page_load 15:32:39 INFO - PROCESS | 20539 | _x_x_mozilla_page_load_details 15:32:39 INFO - PROCESS | 20539 | |i|pagename|runs| 15:32:39 INFO - PROCESS | 20539 | |0;dojo.html;3016.3665630217656;3045.649750278716;3057.143999680089;3074.062410964655;3085.660577336493;5277.947220527793;5281.603879709028;5323.307969963909;5339.878625488652;5467.17992301155;5357.08929481988;5414.214938833867;5434.347878254605;5440.619156659035;5510.669359838413;4869.5130486951375;4948.2824990376375;4975.552200301972;5002.299678045077;5034.697918124906;4965.553100220979;4980.9252861207115;4989.950100498985;4997.175466048097;5001.649884508086;4807.326974223612;4826.1795494765975;4849.806007759686;4920.3111564381015;4991.425986011619;4827.951720482821;4866.853994380174;4880.463149053601;4922.089413458486;4932.457429682732;4810.374651295309;4860.100881336929;4879.048585525824;4889.779959901813;4909.361782968192;5276.525112739833;5308.522232999048;5324.1215199492035;5326.2543243945875;5406.351237851443;5660.264165658479;5690.943090569082;5706.885862282731;5715.3998830122655;5715.828525144252;5704.1443783432405;5734.025215713297;5830.941690583082;5831.620944638585;5832.125181222808;5277.577793776489;5404.1083221268445;5409.6754194747655;5435.42927992563;5447;5749.942500574941;5752.28096487939;5800.39095894925;5803.5357171426185;5869.735861886225;5504.91742623861;5572.916406253909;5573.470520300565;5578.860528486739;5589.944100558942;5649.6327738696855;5649.774009039593;5676.375598684142;5711.200431939532;5793.073108302736;5777.45114214149;5784.88430231393;5798.362180160179;5826.912596311059;5828.504577110908;5768;5780.768769249267;5784.652920824764;5790.565707571949;5812.070068788974;4269.509006464296;4300.677449191323;4300.6989510734575;4363.869083927487;4417.491988421372;3874.1864208515963;3898.863539776094;3942.48747662802;3956.485656864589;3977.801109944491;5423.674579525241;5493.615446918678;5502.889942201214;5511.917321240185;5524.281843360418;5663.745131469093;5727.3699893011735;5812.273465816773;5822.7962021329895;5845;5428.077226871442;5452.40023597404;5460.208269800856;5488.945110548843;5557;4777.737224452619;4800.3759511263315;4813.879653008633;4830.3237546743485;4857.295692124622;5879.559033072622;5963.777425627736;5963.7912673056235;5965.642061476326;5990.580659353891;5740.225069615715;5760.567957403127;5765.048766953406;5790.884182316246;5886.23478947734;5962.284525856925;5972.611780234271;5994.580379373577;5997.3402925677265;6016.518678505797;5636.718164091697;5671.347795003628;5690.5163061140265;5710.486056254957;5715.2855893013375;5776.277965254343;5823.8835223294445;5845.09401042839;5848.824535263949;5881.588288819741;5656.519195868397;5677.971610142088;5688.914666280092;5695.829125126253;5699.8860022800145;5616.747246373841;5695.629784064188;5706.80026199081;5710.914336284876;5711.086226203787;5452.890942181213;5500.147477141049;5516.14499752539;5555.22226888244;5572.804951826666;5746.597738158289;5770.769169233184;5773.047447171338;5774.422557744192;5787.884242315215;5583.776648933997;5622.606417550732;5655.377908429987;5657.236273103243;5662.716864156858 15:32:39 INFO - PROCESS | 20539 | |1;ext.html;556.5432480482337;580.6516090345793;581.8981678206313;582.4699523433676;609.448449153516;43921;45562.08875822482;45586.544134558724;45615.31577026339;45683.31475027873;42504.57495425045;42718.14563708724;43001.13997720044;43040;43271.35092973608;8852.8672069919;8864;8994.055624159468;9017.95491022544;9021.729348119534;8472.110428405022;8526.616302266382;8556.61495232716;8561.101084386144;8566.700165494209;8602;8642.30861531079;8665.523396213206;8670.479771213715;8690.435121717068;8854.778630534289;8873.645054197825;8888.60001299943;8904.777380565505;8924.910750892474;8754.518501482416;8769.429987050822;8814.603342849523;8840.762293278945;8889.155530224618;40722.79638601818;41231.38152927708;41269.58730412687;41314.586854131376;41783.582164178275;3355.234035780548;3450.413429716929;3588.3899737044767;3750.0124933785137;3992.9635885698212;30950.380992380025;31364.843175784205;31384.843075784476;31406.842965785254;31494.803357445995;4216.831326746927;4277.807498662568;4461.196984542781;4467;4474.418325617681;313495;313985;314366;315096;315800;44819;44837.77581112139;44847.327290090674;44871.77564112159;45108.77445612751;31310.68689313123;32073;32105.197370065936;33647.831760841036;33779.662203378146;14510.782338264935;14677.486287980082;14703.338349774285;14754.778678319833;14774.704505909822;10829;10845.295055821347;10878.891211087788;10941.671749847517;11152.498137583829;18242.45272641823;18262.726059109125;18272.725909111374;18274.45176644703;18369.81630183708;6889.414399776075;6916.896246556305;7000.92999070013;7088.610126443095;7143.24995875436;777.9494332868345;854.7093689296283;922.4050487435567;967.5887747707196;974.498133461268;26961;28476.430471390457;28745.28136796555;28897.42205155885;28974.565381519293;941.0495399646406;963.2246041936169;972.4943029624555;996.6760802739138;997.4165113408737;14297.356618952172;16605.83394166067;17259.654806903793;17380.65238695219;18051.909740451476;540080;540909;542881;543790;545501;56160.43839561634;56684.71657641685;56701.43298567044;56731.43268567262;56970.43029569651;1175.7295821960997;1286.9356532173354;1332.7134666046848;1338.9489250938161;1353.4586165533865;29457.263568410963;31146;31883.52174717335;32032.35935281328;32363.676363236067;43165.3525197116;43719.56280437282;43800.780996094814;44029;44062.55937440713;371743;371750;373213;373900;497076;24412.145574904793;24429.755702443457;24456.877715611306;24575;24587.754122458547;37456.81271593733;37777.05557361088;38097.80951095227;38301.233975320894;38553.80723096366;32657;32804;32842.83578582092;33214;33250.33499330048;37658.2468350626;37858;38050.2389952205;38791.80604096961;40019.199616008096;28820.423591527633;29312.120636380943;36602.26795464129;38137.23725525529;39483.40774888321;32131.51802723008;34714.48711667467;35028.9491315261;35354.82322588371;35461.46807797936;26343.736562634127;27115.72884271132;27187.86406067957;27260.72739272661;27388.58917116205 15:32:39 INFO - PROCESS | 20539 | |2;jquery.html;370.4420973180192;378.8408868275324;384.97112716546246;394.33160792456795;401.3237694484793;17517.124143792822;19657.115429805657;20030.699539506903;20096.59806803865;20153.798462015377;16942.491725248263;17162;17527.82472175281;17588.12059397028;17597.91201043993;5502.752376143083;5525.585581081415;5731.455511726379;5736.885262294752;5761.337446193678;5575.163725441196;5696.060150075233;5696.800611978581;5704.401037891003;5705.058665320217;5568.6658800472105;5662.716864156796;5666.065099258617;5680.31836179657;5698.772049118031;5877.764889404419;5958;5982.521398288127;5984.461398474136;5986.610870293439;5596.58025648078;5714.428557144294;5729.226554415184;5739.684317362543;5773.566982476289;13657.931710341483;13899.861001389958;13982.230977296245;16260.593485162966;23167.3049808506;2290.2900100968754;2411.397150712322;2761.3412228796838;2761.792865535073;2955.571442140899;9612.375195612332;10105.848412273821;10393.37639741618;10664.680059598224;12910.289934053624;1920.69268916974;1952.4045166224296;1972.5364539333245;1974.4076776966997;1993.9003049847595;82144.58927705324;83205;83523;84111.5794421024;85383.57308213481;10722.410267435365;10791.136709063256;11023.228374013903;11121.55513779456;11190.776184476264;14929.70140597182;15008.849911500745;15029.173395463136;15048.247587620575;15146.318415671321;6198.194234749544;6205.131281620576;6864.313568643096;7541.472096953161;7753.10839253493;7082.256363081905;7110.537815042006;7281.745138920112;7299.708011679473;7316.0489136411925;4519.846224940303;4565.132624801277;4661.207594708908;4792.688475249168;4872.293517440023;1912.2924517928454;1924.5669724311917;1946.834519065867;1950.629380417716;2033.786452422504;889.1863944490718;997.2969056814928;1002.7793885345212;1010.8534262531891;1012.5696578953915;18406.35577754799;19248;19351.51621209481;19797.60404791896;20181.082797134248;889.4529864133511;937.4890684576922;945.3902233059638;954.4559601027348;971.4025874087386;10277.640282590222;10484.362357782855;10717.678469645924;10815.322700849543;10870.94374291596;508176;511777;514904;514940;515889;87086;89095;89263;89898.55050724704;90105.54947225221;924.9306302027375;951.4814426137772;979.7746518300688;980.7450062983532;987.8468837330225;16351.704593731261;16748.41380551675;16849.747253790956;17016.31934722647;17537.473875783748;41189;41709.79145104255;41935.790321048196;43602.56397435985;44125;55587;57234.7138264306;57263.141052885076;57395.713021434625;59101;6210.782622608187;8333.791655208668;8506.574671266288;8637.524936128322;9099.454032758056;12520.123591348882;12728.299943502825;12847.293398863152;13037.804432933703;13318.400671969592;10764.892351076389;10871.510782014986;11190.94404527972;11265.155113366367;11737.941310293394;10885.510152043336;10968.17738669587;11201.21591488588;11216.775664486502;11918.702032449259;11005.449727513753;11006.669799906016;11262.211645184758;11502.194846360675;11559.30644161353;8385.706500272461;8581.699640512552;8625.353098517511;8744.431611945203;8864.290856731575;9810.558524866256;11039.889601104207;11641;12018;12124.696882578006 15:32:39 INFO - PROCESS | 20539 | |3;mootools.html;1431.9069260498068;1482.4440834686993;1530.1048886401454;1610.0742073307852;1637.4514537629893;7505.887411688829;7751.302382785549;8269.421140520159;8815.911840881588;8837.337199710024;8362.205590468895;8680.56597170142;8682.348823838205;8794.604242809073;8812.206901378875;2343.2501599488087;2353.776391242829;2367.846090004144;2368.656544801003;2376.192094687806;2291.86248825071;2301.8158547316257;2331.1491305673394;2331.557004169211;2338.3569518382496;2279.9772002280015;2280.908763649452;2281.155972290255;2346.21401830387;2360.9173678921243;2264.53577016712;2266.8866556672183;2267.8979445924974;2274.113095892595;2292.0487997481027;2291.7364503082194;2302.24026071396;2304.8271379646594;2312.0405031911905;2312.7802858728564;8729.388942774009;8801.603927823264;8847.867281990711;8868.733937981871;8875.644974201025;5199.922001169985;5348.411674715778;5348.679079255218;5351.812686555991;5354.41101478837;3357.4555704376016;3387.5426817379584;3485.3203625293077;3499.61504234534;3574.571051473814;1155.4915837031679;1210.8849659282441;1227.416976935957;1233.2600439736086;1234.1916044990546;12070.215435996632;12089.274643521505;12101.93949030258;12142.150049496538;12192.57325993586;4327.783610819446;4549.499555048942;4768.1417344878255;4771.379720636295;4776.09254241693;10231.079202871777;10269.691909242734;10275.383476991405;10281.845772313422;10285.22860785444;5248.396434410091;5310.468953104659;5341.092014357491;5342.6260161788305;5351.919721204185;4405.7797110145;4598.839040633628;4772.451168115642;4887.266909963534;4892.608591312686;3838.328292548793;3843.7309388342546;3955.3473676843;3956.7032472564674;4022.4770779798437;1245.588955644635;1269.955551555691;1272.6818295426144;1274.9681257968439;1289.8839104480642;782.2568559868148;853.7950891785927;857.0957639690187;876.2420506262038;940.7977284883783;5420.566354691615;5591.860203494945;5613.887722245532;5902.085176797603;5997.8707558815995;868.1708967935606;939.7650587353162;951.1819834941945;986.9703908882746;1032.318669678009;3837.136644255076;3969.7816620085596;3972.7020473464604;4069.2878746219885;4074.1851629674184;10721.83917241242;10991.945040274748;11092.33445993243;11097.83353249702;11103.611373601885;10882.564697412174;10922.235443518877;10933.18001149917;10975.780484390427;10976.451177441097;7626.504277221963;7935;7987.081485629227;7991.8401631967035;8191.303739182117;5660.433956604306;5828.825135245949;5876.853078673067;5910.527157827278;5939.168516407793;9595.808083838423;9783.853242201514;9809.950950245204;9880.308378413441;9948.751281218027;9377.906220937975;9524.380915240487;9551.235901128031;10023.749406264902;10170.949145254226;6550.705218265094;7370.262973702587;7403.1486379064945;7404.703811847466;7515.286047825448;8262.545559994258;8394.160583941557;8398.496090234605;8400.033996090528;8405.453645513022;7507.699692012258;7615.791420487996;7751.9612401939885;7828.373730101464;7830.569318687527;7349.77950661481;7412;7448.329650331496;7475.588842613491;7790.065192176975;6705.195376554844;6895.103636527219;6931.584104953719;6939.4795390346935;6957.851954427463;5105.642605017613;5145.845624631267;5175.094358487325;5354.063038968087;5412.134058550613;5099.1331473648825;5152.3044389007;5190.870228244324;5245.082110630548;5302.621318457152 15:32:39 INFO - PROCESS | 20539 | |4;prototype.html;327.1869404529744;336.5591075690845;338.43312451643493;351.2658543643784;352.10916381554676;5522.22688823564;5545.474994376548;5554.4167862374425;5579.9163012554745;5581.274434323543;5440.537554307879;5441.428649991753;5487.134374312733;5490.588205884555;5500.532454741352;4027.295223335912;4145.3574695922025;4202.873913782591;4276.4440622719;4325.372820940962;4271.508776490697;4281.464816897887;4281.807318670667;4284.335927931175;4314.395984562164;4250.468691413574;4261.21167583998;4263.531011588722;4276.144771045788;4288.485381754178;4029.2545879012478;4211.378619231587;4265.765382903939;4288.370419240699;4301.139772045603;3721.0511319613597;3726.6832319252894;3730.8880733578035;3732.7387082904206;3753.230587729536;5386.730663466811;5413.729313534308;5428.185772134172;5432.972835135839;5448.346198456211;4617.699849509771;4900.607951363882;4900.950990490085;4930.852074437773;4931.802727890916;5653.897489989454;5700.603352178701;5706.400827913051;5725.713714314267;5744.167095771131;4117.938230926538;4132.318167502359;4137.441445404862;4140.834366625331;4154.688398370135;5931.970340148315;5940.6435613863305;5986.2217911671205;6055.424734650202;6081.756729730805;4177.603127702924;4201.45381100455;4201.747895126302;4229.598188172119;4237.343211802176;4258.488981322261;4265.97867010663;4272.081502476983;4277.2087163874785;4297.076128632359;4677.883052923636;4816.301636262722;4859.271109333628;4869.756512174448;4886.682365646222;5714.914276285859;5734.311882574118;5735.397783232784;5748.48263656273;5748.683822389725;1468.860458256464;1474.5944865161953;1476.143836574784;1485.9108453492825;1496.880249580031;910.8087301666592;932.9720108396623;954.8710924025306;969.1713584884963;977.2719324103447;5492.857785463672;5632.774689012475;5639.548836093103;5647.237622920935;5651.802186923438;5981.700914954235;5999.820005399845;6001.12983617373;6012.917674818575;6044.065898912306;5377.865553361119;5556.222128901876;5580.400641586154;5619.915701264485;5701.372848986608;3062.923426914345;3099.1632259289863;3109.595752552154;3142.245860993345;3146.348167212232;5953.136795164677;6072.483838873745;6126.693665316717;6129.295131059896;6129.693515324216;5936.614120082181;5989.9101513477335;5996.850078747979;6001.5798894077;6003.969980150071;6100.420460056288;6125.387461253839;6127.050307202391;6173.969130154321;6177.96911015451;5738.8278351649515;5788.971055144697;5791.189233507396;5839.7372118255635;5930.199423077829;5778.2376375204285;5821.94178058214;5876.706164691663;5879.559033072622;5884.941150588611;5944.762209511571;5982.623996480746;6080.3615620361;6111.5110791137495;6139.789675716827;4179.477565304337;4181.770002649883;4197.286461301647;4229;4230.217409779078;5898.849724303891;5927.798988546137;5968.820935371946;5968.8806223876145;5993.0710739835395;5515.007298686275;5746.827595172152;5752.165935939349;5754.53963682896;5823.679697616672;5710.514606258348;5743.851229754149;5754.56840736938;5769.643918841248;5783.508401785895;5522.5858060644805;5678.574106942078;5692.861427714556;5718.225970859213;5721.771129154788;5782.826515204551;5834.883302334015;5849.327327357409;5852.741660542833;5857.619254748428;5710.371859095413;5733.226014487991;5754.68349240779;5754.856128596819;5797.739101740347 15:32:39 INFO - PROCESS | 20539 | |5;yui.html;715.4097869257863;727.9745208917687;762.9313361797441;767.3362541401689;820.421602770047;15179.924100379496;16017.439389621366;16034.83965160348;16095.356185752556;16164.919175404137;14968.25158742064;15138.621534461616;15181.77227341588;15199.164045977466;15202.315895784688;645.8901986662279;654.0614218596306;763.1109757132933;765.8430021845522;790.083503136362;782.2451334462243;785.5522352259214;787.6691789448416;793.8452001859611;797.7526966640331;838.7022606974527;844.307667712476;845.720912099009;847.2628812932758;850.0691742541907;832.650286879506;839.6095815445847;843.7637461510786;845.327964268405;845.5603086395071;614.5390956782413;614.8493619063358;615.4153554123601;617.478230894893;619.1764952613014;14347;14347.497837575738;14399.136051836818;14429.989900706954;14450.205238711867;14274.714505709828;14323.498677546237;14425.639359016004;14634.926825365912;14788.40846366144;11783.351915644636;11879.584214552535;11880.227785193934;11903.285802851857;12511.249325040435;3670.724695647837;3756.1683889091278;3814.141818090935;3835.0987517933263;3926.9410958835642;81859.5907020467;82256;83448;83483;83486.58256708739;9566.856497152548;9644.421334719938;9803.522799986207;9829.22409532704;9936.50317484123;20315.390538283875;20342;20573.79426205719;20577.279795207094;20620.587588248152;8163.79590510242;8237.917620823835;8241.670333186605;8246.8350632987;8272.875906861402;4410.25025745624;4504.707194032378;4513.210188217049;4540.704854184468;4653.813847446132;3737.3459644562095;3836.0793409582056;3843.6540711336115;3857.72995890285;3872.7482713623526;581.5086252116954;617.6664601115438;624.8406656302705;636.901280301554;684.3498676257575;636.7675798333574;675.5068799776093;696.895465680152;711.1679335177854;712.9857402851914;9740.46427446483;9844;10119.7470063249;10125;10356.430396328124;582.4612233683825;645.3739872323838;688.8725585766649;713.2403989750899;725.0900120348929;4449.755263460476;4658.650601204923;4746.59653929413;4812.5081224820415;4821.456075760029;73195;74552.62723686347;126846;130959;131582;107632.46183769031;110539;110586;111537;112210.43894780474;60044;87864.5606771962;97569;97811;104128;8825.38222324431;9168.633254670005;9361.204297634777;9415.717528474157;9469;56136.719316403156;56223;57185;57822;59218;76452.61773691096;83644.58177709073;85388;87405.56297218728;90165;11555.711107222387;11744.647660570197;11798.410079496163;11914.285142891455;12279.631611051684;13271.203727776365;13524.391402387113;13723.099067401114;13732.862671373558;13912.60424301245;12793.360331983178;12987.440519537615;13223.206607603575;13529.2558909257;13956.930215348859;12397.566085186974;12424.440900159696;12464.688382790502;12600.866873065015;12608;12638.2417054977;12684.365781710692;13056.412461439448;13166.025096235642;13414.932925335312;10213.489325533843;10272.589096436059;10364.896351036394;10469.895301046892;10755.462226888782;9949.701508954742;10510.737231569272;10527.4736263185;10546.947265263932;10589.152867770406 15:32:39 INFO - PROCESS | 20539 | __end_tp_report 15:32:39 INFO - PROCESS | 20539 | __start_cc_report 15:32:39 INFO - PROCESS | 20539 | _x_x_mozilla_cycle_collect,297 15:32:39 INFO - PROCESS | 20539 | __end_cc_report 15:32:39 INFO - PROCESS | 20539 | __startTimestamp1474669959864__endTimestamp 15:32:39 INFO - PROCESS | 20539 | 15:32:39 INFO - PROCESS | 20539 | ------- Summary: start ------- 15:32:39 INFO - PROCESS | 20539 | Number of tests: 6 15:32:39 INFO - PROCESS | 20539 | 15:32:39 INFO - PROCESS | 20539 | [#0] dojo.html Cycles:165 Average:5352.54 Median:5573.47 stddev:623.00 (11.2%) stddev-sans-first:597.34 15:32:39 INFO - PROCESS | 20539 | Values: 3016.4 3045.6 3057.1 3074.1 3085.7 5277.9 5281.6 5323.3 5339.9 5467.2 5357.1 5414.2 5434.3 5440.6 5510.7 4869.5 4948.3 4975.6 5002.3 5034.7 4965.6 4980.9 4990.0 4997.2 5001.6 4807.3 4826.2 4849.8 4920.3 4991.4 4828.0 4866.9 4880.5 4922.1 4932.5 4810.4 4860.1 4879.0 4889.8 4909.4 5276.5 5308.5 5324.1 5326.3 5406.4 5660.3 5690.9 5706.9 5715.4 5715.8 5704.1 5734.0 5830.9 5831.6 5832.1 5277.6 5404.1 5409.7 5435.4 5447.0 5749.9 5752.3 5800.4 5803.5 5869.7 5504.9 5572.9 5573.5 5578.9 5589.9 5649.6 5649.8 5676.4 5711.2 5793.1 5777.5 5784.9 5798.4 5826.9 5828.5 5768.0 5780.8 5784.7 5790.6 5812.1 4269.5 4300.7 4300.7 4363.9 4417.5 3874.2 3898.9 3942.5 3956.5 3977.8 5423.7 5493.6 5502.9 5511.9 5524.3 5663.7 5727.4 5812.3 5822.8 5845.0 5428.1 5452.4 5460.2 5488.9 5557.0 4777.7 4800.4 4813.9 4830.3 4857.3 5879.6 5963.8 5963.8 5965.6 5990.6 5740.2 5760.6 5765.0 5790.9 5886.2 5962.3 5972.6 5994.6 5997.3 6016.5 5636.7 5671.3 5690.5 5710.5 5715.3 5776.3 5823.9 5845.1 5848.8 5881.6 5656.5 5678.0 5688.9 5695.8 5699.9 5616.7 5695.6 5706.8 5710.9 5711.1 5452.9 5500.1 5516.1 5555.2 5572.8 5746.6 5770.8 5773.0 5774.4 5787.9 5583.8 5622.6 5655.4 5657.2 5662.7 15:32:39 INFO - PROCESS | 20539 | 15:32:39 INFO - PROCESS | 20539 | [#1] ext.html Cycles:180 Average:55733.66 Median:39137.61 stddev:114314.04 (292.1%) stddev-sans-first:114559.65 15:32:39 INFO - PROCESS | 20539 | Values: 556.5 580.7 581.9 582.5 609.4 43921.0 45562.1 45586.5 45615.3 45683.3 42504.6 42718.1 43001.1 43040.0 43271.4 8852.9 8864.0 8994.1 9018.0 9021.7 8472.1 8526.6 8556.6 8561.1 8566.7 8602.0 8642.3 8665.5 8670.5 8690.4 8854.8 8873.6 8888.6 8904.8 8924.9 8754.5 8769.4 8814.6 8840.8 8889.2 40722.8 41231.4 41269.6 41314.6 41783.6 3355.2 3450.4 3588.4 3750.0 3993.0 30950.4 31364.8 31384.8 31406.8 31494.8 4216.8 4277.8 4461.2 4467.0 4474.4 313495.0 313985.0 314366.0 315096.0 315800.0 44819.0 44837.8 44847.3 44871.8 45108.8 31310.7 32073.0 32105.2 33647.8 33779.7 14510.8 14677.5 14703.3 14754.8 14774.7 10829.0 10845.3 10878.9 10941.7 11152.5 18242.5 18262.7 18272.7 18274.5 18369.8 6889.4 6916.9 7000.9 7088.6 7143.2 777.9 854.7 922.4 967.6 974.5 26961.0 28476.4 28745.3 28897.4 28974.6 941.0 963.2 972.5 996.7 997.4 14297.4 16605.8 17259.7 17380.7 18051.9 540080.0 540909.0 542881.0 543790.0 545501.0 56160.4 56684.7 56701.4 56731.4 56970.4 1175.7 1286.9 1332.7 1338.9 1353.5 29457.3 31146.0 31883.5 32032.4 32363.7 43165.4 43719.6 43800.8 44029.0 44062.6 371743.0 371750.0 373213.0 373900.0 497076.0 24412.1 24429.8 24456.9 24575.0 24587.8 37456.8 37777.1 38097.8 38301.2 38553.8 32657.0 32804.0 32842.8 33214.0 33250.3 37658.2 37858.0 38050.2 38791.8 40019.2 28820.4 29312.1 36602.3 38137.2 39483.4 32131.5 34714.5 35028.9 35354.8 35461.5 26343.7 27115.7 27187.9 27260.7 27388.6 15:32:39 INFO - PROCESS | 20539 | 15:32:39 INFO - PROCESS | 20539 | [#2] jquery.html Cycles:180 Average:29289.55 Median:20795.16 stddev:84527.25 (406.5%) stddev-sans-first:84736.48 15:32:39 INFO - PROCESS | 20539 | Values: 370.4 378.8 385.0 394.3 401.3 17517.1 19657.1 20030.7 20096.6 20153.8 16942.5 17162.0 17527.8 17588.1 17597.9 5502.8 5525.6 5731.5 5736.9 5761.3 5575.2 5696.1 5696.8 5704.4 5705.1 5568.7 5662.7 5666.1 5680.3 5698.8 5877.8 5958.0 5982.5 5984.5 5986.6 5596.6 5714.4 5729.2 5739.7 5773.6 13657.9 13899.9 13982.2 16260.6 23167.3 2290.3 2411.4 2761.3 2761.8 2955.6 9612.4 10105.8 10393.4 10664.7 12910.3 1920.7 1952.4 1972.5 1974.4 1993.9 82144.6 83205.0 83523.0 84111.6 85383.6 10722.4 10791.1 11023.2 11121.6 11190.8 14929.7 15008.8 15029.2 15048.2 15146.3 6198.2 6205.1 6864.3 7541.5 7753.1 7082.3 7110.5 7281.7 7299.7 7316.0 4519.8 4565.1 4661.2 4792.7 4872.3 1912.3 1924.6 1946.8 1950.6 2033.8 889.2 997.3 1002.8 1010.9 1012.6 18406.4 19248.0 19351.5 19797.6 20181.1 889.5 937.5 945.4 954.5 971.4 10277.6 10484.4 10717.7 10815.3 10870.9 508176.0 511777.0 514904.0 514940.0 515889.0 87086.0 89095.0 89263.0 89898.6 90105.5 924.9 951.5 979.8 980.7 987.8 16351.7 16748.4 16849.7 17016.3 17537.5 41189.0 41709.8 41935.8 43602.6 44125.0 55587.0 57234.7 57263.1 57395.7 59101.0 6210.8 8333.8 8506.6 8637.5 9099.5 12520.1 12728.3 12847.3 13037.8 13318.4 10764.9 10871.5 11190.9 11265.2 11737.9 10885.5 10968.2 11201.2 11216.8 11918.7 11005.4 11006.7 11262.2 11502.2 11559.3 8385.7 8581.7 8625.4 8744.4 8864.3 9810.6 11039.9 11641.0 12018.0 12124.7 15:32:39 INFO - PROCESS | 20539 | 15:32:39 INFO - PROCESS | 20539 | [#3] mootools.html Cycles:180 Average:5722.05 Median:5149.08 stddev:3232.55 (62.8%) stddev-sans-first:3225.54 15:32:39 INFO - PROCESS | 20539 | Values: 1431.9 1482.4 1530.1 1610.1 1637.5 7505.9 7751.3 8269.4 8815.9 8837.3 8362.2 8680.6 8682.3 8794.6 8812.2 2343.3 2353.8 2367.8 2368.7 2376.2 2291.9 2301.8 2331.1 2331.6 2338.4 2280.0 2280.9 2281.2 2346.2 2360.9 2264.5 2266.9 2267.9 2274.1 2292.0 2291.7 2302.2 2304.8 2312.0 2312.8 8729.4 8801.6 8847.9 8868.7 8875.6 5199.9 5348.4 5348.7 5351.8 5354.4 3357.5 3387.5 3485.3 3499.6 3574.6 1155.5 1210.9 1227.4 1233.3 1234.2 12070.2 12089.3 12101.9 12142.2 12192.6 4327.8 4549.5 4768.1 4771.4 4776.1 10231.1 10269.7 10275.4 10281.8 10285.2 5248.4 5310.5 5341.1 5342.6 5351.9 4405.8 4598.8 4772.5 4887.3 4892.6 3838.3 3843.7 3955.3 3956.7 4022.5 1245.6 1270.0 1272.7 1275.0 1289.9 782.3 853.8 857.1 876.2 940.8 5420.6 5591.9 5613.9 5902.1 5997.9 868.2 939.8 951.2 987.0 1032.3 3837.1 3969.8 3972.7 4069.3 4074.2 10721.8 10991.9 11092.3 11097.8 11103.6 10882.6 10922.2 10933.2 10975.8 10976.5 7626.5 7935.0 7987.1 7991.8 8191.3 5660.4 5828.8 5876.9 5910.5 5939.2 9595.8 9783.9 9810.0 9880.3 9948.8 9377.9 9524.4 9551.2 10023.7 10170.9 6550.7 7370.3 7403.1 7404.7 7515.3 8262.5 8394.2 8398.5 8400.0 8405.5 7507.7 7615.8 7752.0 7828.4 7830.6 7349.8 7412.0 7448.3 7475.6 7790.1 6705.2 6895.1 6931.6 6939.5 6957.9 5105.6 5145.8 5175.1 5354.1 5412.1 5099.1 5152.3 5190.9 5245.1 5302.6 15:32:39 INFO - PROCESS | 20539 | 15:32:39 INFO - PROCESS | 20539 | [#4] prototype.html Cycles:180 Average:4854.70 Median:5600.60 stddev:1437.70 (25.7%) stddev-sans-first:1400.99 15:32:39 INFO - PROCESS | 20539 | Values: 327.2 336.6 338.4 351.3 352.1 5522.2 5545.5 5554.4 5579.9 5581.3 5440.5 5441.4 5487.1 5490.6 5500.5 4027.3 4145.4 4202.9 4276.4 4325.4 4271.5 4281.5 4281.8 4284.3 4314.4 4250.5 4261.2 4263.5 4276.1 4288.5 4029.3 4211.4 4265.8 4288.4 4301.1 3721.1 3726.7 3730.9 3732.7 3753.2 5386.7 5413.7 5428.2 5433.0 5448.3 4617.7 4900.6 4901.0 4930.9 4931.8 5653.9 5700.6 5706.4 5725.7 5744.2 4117.9 4132.3 4137.4 4140.8 4154.7 5932.0 5940.6 5986.2 6055.4 6081.8 4177.6 4201.5 4201.7 4229.6 4237.3 4258.5 4266.0 4272.1 4277.2 4297.1 4677.9 4816.3 4859.3 4869.8 4886.7 5714.9 5734.3 5735.4 5748.5 5748.7 1468.9 1474.6 1476.1 1485.9 1496.9 910.8 933.0 954.9 969.2 977.3 5492.9 5632.8 5639.5 5647.2 5651.8 5981.7 5999.8 6001.1 6012.9 6044.1 5377.9 5556.2 5580.4 5619.9 5701.4 3062.9 3099.2 3109.6 3142.2 3146.3 5953.1 6072.5 6126.7 6129.3 6129.7 5936.6 5989.9 5996.9 6001.6 6004.0 6100.4 6125.4 6127.1 6174.0 6178.0 5738.8 5789.0 5791.2 5839.7 5930.2 5778.2 5821.9 5876.7 5879.6 5884.9 5944.8 5982.6 6080.4 6111.5 6139.8 4179.5 4181.8 4197.3 4229.0 4230.2 5898.8 5927.8 5968.8 5968.9 5993.1 5515.0 5746.8 5752.2 5754.5 5823.7 5710.5 5743.9 5754.6 5769.6 5783.5 5522.6 5678.6 5692.9 5718.2 5721.8 5782.8 5834.9 5849.3 5852.7 5857.6 5710.4 5733.2 5754.7 5754.9 5797.7 15:32:39 INFO - PROCESS | 20539 | 15:32:39 INFO - PROCESS | 20539 | [#5] yui.html Cycles:180 Average:21401.46 Median:4597.26 stddev:31949.93 (695.0%) stddev-sans-first:32001.80 15:32:39 INFO - PROCESS | 20539 | Values: 715.4 728.0 762.9 767.3 820.4 15179.9 16017.4 16034.8 16095.4 16164.9 14968.3 15138.6 15181.8 15199.2 15202.3 645.9 654.1 763.1 765.8 790.1 782.2 785.6 787.7 793.8 797.8 838.7 844.3 845.7 847.3 850.1 832.7 839.6 843.8 845.3 845.6 614.5 614.8 615.4 617.5 619.2 14347.0 14347.5 14399.1 14430.0 14450.2 14274.7 14323.5 14425.6 14634.9 14788.4 11783.4 11879.6 11880.2 11903.3 12511.2 3670.7 3756.2 3814.1 3835.1 3926.9 81859.6 82256.0 83448.0 83483.0 83486.6 9566.9 9644.4 9803.5 9829.2 9936.5 20315.4 20342.0 20573.8 20577.3 20620.6 8163.8 8237.9 8241.7 8246.8 8272.9 4410.3 4504.7 4513.2 4540.7 4653.8 3737.3 3836.1 3843.7 3857.7 3872.7 581.5 617.7 624.8 636.9 684.3 636.8 675.5 696.9 711.2 713.0 9740.5 9844.0 10119.7 10125.0 10356.4 582.5 645.4 688.9 713.2 725.1 4449.8 4658.7 4746.6 4812.5 4821.5 73195.0 74552.6 126846.0 130959.0 131582.0 107632.5 110539.0 110586.0 111537.0 112210.4 60044.0 87864.6 97569.0 97811.0 104128.0 8825.4 9168.6 9361.2 9415.7 9469.0 56136.7 56223.0 57185.0 57822.0 59218.0 76452.6 83644.6 85388.0 87405.6 90165.0 11555.7 11744.6 11798.4 11914.3 12279.6 13271.2 13524.4 13723.1 13732.9 13912.6 12793.4 12987.4 13223.2 13529.3 13956.9 12397.6 12424.4 12464.7 12600.9 12608.0 12638.2 12684.4 13056.4 13166.0 13414.9 10213.5 10272.6 10364.9 10469.9 10755.5 9949.7 10510.7 10527.5 10546.9 10589.2 15:32:39 INFO - PROCESS | 20539 | -------- Summary: end -------- 15:32:39 INFO - PROCESS | 20539 | 15:32:40 INFO - TEST-INFO | 20539: exit 0 15:32:40 INFO - TEST-OK | dromaeo_css | took 1114275ms 15:32:40 INFO - TEST-START | kraken 15:32:40 INFO - operating with platform_type : linux_ 15:32:40 INFO - Initialising browser for kraken test... 15:32:40 INFO - TEST-INFO | started process 20903 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNKJimf/profile http://localhost:48488/getInfo.html) 15:32:45 INFO - PROCESS | 20903 | __metrics Screen width/height:1600/1200 15:32:45 INFO - PROCESS | 20903 | colorDepth:24 15:32:45 INFO - PROCESS | 20903 | Browser inner width/height: 1024/697 15:32:45 INFO - PROCESS | 20903 | __metrics 15:32:46 ERROR - PROCESS | 20903 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 15:32:47 INFO - TEST-INFO | 20903: exit 0 15:32:47 INFO - Browser initialized. 15:32:47 INFO - Running cycle 1/1 for kraken test... 15:32:47 INFO - TEST-INFO | started process 21027 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNKJimf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:32:59 INFO - PROCESS | 21027 | RSS: Main: 185425920 15:32:59 INFO - PROCESS | 21027 | 15:33:01 INFO - PROCESS | 21027 | Cycle 1(1): loaded http://localhost:48488/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48488/tests/kraken/driver.html?testName=audio-beat-detection) 15:33:02 INFO - PROCESS | 21027 | RSS: Main: 199032832 15:33:02 INFO - PROCESS | 21027 | 15:33:05 INFO - PROCESS | 21027 | Cycle 1(1): loaded http://localhost:48488/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48488/tests/kraken/driver.html?testName=audio-dft) 15:33:06 INFO - PROCESS | 21027 | RSS: Main: 196460544 15:33:06 INFO - PROCESS | 21027 | 15:33:08 INFO - PROCESS | 21027 | Cycle 1(1): loaded http://localhost:48488/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48488/tests/kraken/driver.html?testName=audio-fft) 15:33:09 INFO - PROCESS | 21027 | RSS: Main: 191864832 15:33:09 INFO - PROCESS | 21027 | 15:33:11 INFO - PROCESS | 21027 | Cycle 1(1): loaded http://localhost:48488/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48488/tests/kraken/driver.html?testName=audio-oscillator) 15:33:12 INFO - PROCESS | 21027 | RSS: Main: 192532480 15:33:12 INFO - PROCESS | 21027 | 15:33:14 INFO - PROCESS | 21027 | Cycle 1(1): loaded http://localhost:48488/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48488/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:33:15 INFO - PROCESS | 21027 | RSS: Main: 192958464 15:33:15 INFO - PROCESS | 21027 | 15:33:18 INFO - PROCESS | 21027 | Cycle 1(1): loaded http://localhost:48488/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48488/tests/kraken/driver.html?testName=imaging-darkroom) 15:33:18 INFO - PROCESS | 21027 | RSS: Main: 192839680 15:33:18 INFO - PROCESS | 21027 | 15:33:22 INFO - PROCESS | 21027 | Cycle 1(1): loaded http://localhost:48488/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48488/tests/kraken/driver.html?testName=imaging-desaturate) 15:33:22 INFO - PROCESS | 21027 | RSS: Main: 193474560 15:33:22 INFO - PROCESS | 21027 | 15:33:25 INFO - PROCESS | 21027 | Cycle 1(1): loaded http://localhost:48488/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48488/tests/kraken/driver.html?testName=json-parse-financial) 15:33:26 INFO - PROCESS | 21027 | RSS: Main: 193581056 15:33:26 INFO - PROCESS | 21027 | 15:33:27 INFO - PROCESS | 21027 | Cycle 1(1): loaded http://localhost:48488/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48488/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:33:28 INFO - PROCESS | 21027 | RSS: Main: 193335296 15:33:28 INFO - PROCESS | 21027 | 15:33:30 INFO - PROCESS | 21027 | Cycle 1(1): loaded http://localhost:48488/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48488/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:33:30 INFO - PROCESS | 21027 | RSS: Main: 193425408 15:33:30 INFO - PROCESS | 21027 | 15:33:32 INFO - PROCESS | 21027 | Cycle 1(1): loaded http://localhost:48488/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48488/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:33:33 INFO - PROCESS | 21027 | RSS: Main: 193552384 15:33:33 INFO - PROCESS | 21027 | 15:33:36 INFO - PROCESS | 21027 | Cycle 1(1): loaded http://localhost:48488/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48488/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:33:37 INFO - PROCESS | 21027 | RSS: Main: 193474560 15:33:37 INFO - PROCESS | 21027 | 15:33:39 INFO - PROCESS | 21027 | Cycle 1(1): loaded http://localhost:48488/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48488/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:33:40 INFO - PROCESS | 21027 | RSS: Main: 194039808 15:33:40 INFO - PROCESS | 21027 | 15:33:42 INFO - PROCESS | 21027 | Cycle 1(1): loaded http://localhost:48488/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48488/tests/kraken/driver.html?testName=ai-astar) 15:33:42 INFO - PROCESS | 21027 | RSS: Main: 195502080 15:33:42 INFO - PROCESS | 21027 | 15:33:42 INFO - PROCESS | 21027 | __start_tp_report 15:33:42 INFO - PROCESS | 21027 | _x_x_mozilla_page_load 15:33:42 INFO - PROCESS | 21027 | _x_x_mozilla_page_load_details 15:33:42 INFO - PROCESS | 21027 | |i|pagename|runs| 15:33:42 INFO - PROCESS | 21027 | |0;ai-astar;114;114;116;115;115;114;113;115;112;114 15:33:42 INFO - PROCESS | 21027 | |1;audio-beat-detection;146;121;122;177;131;120;120;121;159;121 15:33:42 INFO - PROCESS | 21027 | |2;audio-dft;163;164;163;165;168;166;167;166;161;164 15:33:42 INFO - PROCESS | 21027 | |3;audio-fft;77;78;77;111;77;79;76;76;99;77 15:33:42 INFO - PROCESS | 21027 | |4;audio-oscillator;84;83;115;83;87;83;97;84;83;118 15:33:42 INFO - PROCESS | 21027 | |5;imaging-gaussian-blur;118;119;118;118;118;118;117;118;118;117 15:33:42 INFO - PROCESS | 21027 | |6;imaging-darkroom;146;149;147;147;154;147;146;146;148;149 15:33:42 INFO - PROCESS | 21027 | |7;imaging-desaturate;96;96;97;97;95;96;95;97;96;96 15:33:42 INFO - PROCESS | 21027 | |8;json-parse-financial;52;52;56;51;61;58;53;53;51;59 15:33:42 INFO - PROCESS | 21027 | |9;json-stringify-tinderbox;61;60;60;61;62;60;61;60;61;62 15:33:42 INFO - PROCESS | 21027 | |10;stanford-crypto-aes;79;87;81;80;79;79;79;82;80;79 15:33:42 INFO - PROCESS | 21027 | |11;stanford-crypto-ccm;127;125;141;125;122;138;133;136;163;124 15:33:42 INFO - PROCESS | 21027 | |12;stanford-crypto-pbkdf2;167;164;167;164;165;164;164;170;161;166 15:33:42 INFO - PROCESS | 21027 | |13;stanford-crypto-sha256-iterative;67;65;67;68;67;64;65;68;65;66 15:33:42 INFO - PROCESS | 21027 | __end_tp_report 15:33:42 INFO - PROCESS | 21027 | __start_cc_report 15:33:42 INFO - PROCESS | 21027 | _x_x_mozilla_cycle_collect,751 15:33:42 INFO - PROCESS | 21027 | __end_cc_report 15:33:42 INFO - PROCESS | 21027 | __startTimestamp1474670022370__endTimestamp 15:33:42 INFO - PROCESS | 21027 | 15:33:42 INFO - PROCESS | 21027 | ------- Summary: start ------- 15:33:42 INFO - PROCESS | 21027 | Number of tests: 14 15:33:42 INFO - PROCESS | 21027 | 15:33:42 INFO - PROCESS | 21027 | [#0] ai-astar Cycles:10 Average:114.20 Median:114.50 stddev:1.14 (1.0%) stddev-sans-first:1.20 15:33:42 INFO - PROCESS | 21027 | Values: 114.0 114.0 116.0 115.0 115.0 114.0 113.0 115.0 112.0 114.0 15:33:42 INFO - PROCESS | 21027 | 15:33:42 INFO - PROCESS | 21027 | [#1] audio-beat-detection Cycles:10 Average:133.80 Median:126.50 stddev:20.19 (16.0%) stddev-sans-first:20.93 15:33:42 INFO - PROCESS | 21027 | Values: 146.0 121.0 122.0 177.0 131.0 120.0 120.0 121.0 159.0 121.0 15:33:42 INFO - PROCESS | 21027 | 15:33:42 INFO - PROCESS | 21027 | [#2] audio-dft Cycles:10 Average:164.70 Median:165.50 stddev:2.11 (1.3%) stddev-sans-first:2.15 15:33:42 INFO - PROCESS | 21027 | Values: 163.0 164.0 163.0 165.0 168.0 166.0 167.0 166.0 161.0 164.0 15:33:42 INFO - PROCESS | 21027 | 15:33:42 INFO - PROCESS | 21027 | [#3] audio-fft Cycles:10 Average:82.70 Median:77.00 stddev:12.12 (15.7%) stddev-sans-first:12.68 15:33:42 INFO - PROCESS | 21027 | Values: 77.0 78.0 77.0 111.0 77.0 79.0 76.0 76.0 99.0 77.0 15:33:42 INFO - PROCESS | 21027 | 15:33:42 INFO - PROCESS | 21027 | [#4] audio-oscillator Cycles:10 Average:91.70 Median:83.50 stddev:13.77 (16.5%) stddev-sans-first:14.32 15:33:42 INFO - PROCESS | 21027 | Values: 84.0 83.0 115.0 83.0 87.0 83.0 97.0 84.0 83.0 118.0 15:33:42 INFO - PROCESS | 21027 | 15:33:42 INFO - PROCESS | 21027 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 15:33:42 INFO - PROCESS | 21027 | Values: 118.0 119.0 118.0 118.0 118.0 118.0 117.0 118.0 118.0 117.0 15:33:42 INFO - PROCESS | 21027 | 15:33:42 INFO - PROCESS | 21027 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:147.50 stddev:2.42 (1.6%) stddev-sans-first:2.47 15:33:42 INFO - PROCESS | 21027 | Values: 146.0 149.0 147.0 147.0 154.0 147.0 146.0 146.0 148.0 149.0 15:33:42 INFO - PROCESS | 21027 | 15:33:42 INFO - PROCESS | 21027 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 15:33:42 INFO - PROCESS | 21027 | Values: 96.0 96.0 97.0 97.0 95.0 96.0 95.0 97.0 96.0 96.0 15:33:42 INFO - PROCESS | 21027 | 15:33:42 INFO - PROCESS | 21027 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:54.50 stddev:3.63 (6.7%) stddev-sans-first:3.72 15:33:42 INFO - PROCESS | 21027 | Values: 52.0 52.0 56.0 51.0 61.0 58.0 53.0 53.0 51.0 59.0 15:33:42 INFO - PROCESS | 21027 | 15:33:42 INFO - PROCESS | 21027 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.79 (1.3%) stddev-sans-first:0.83 15:33:42 INFO - PROCESS | 21027 | Values: 61.0 60.0 60.0 61.0 62.0 60.0 61.0 60.0 61.0 62.0 15:33:42 INFO - PROCESS | 21027 | 15:33:42 INFO - PROCESS | 21027 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:80.00 stddev:2.51 (3.1%) stddev-sans-first:2.60 15:33:42 INFO - PROCESS | 21027 | Values: 79.0 87.0 81.0 80.0 79.0 79.0 79.0 82.0 80.0 79.0 15:33:42 INFO - PROCESS | 21027 | 15:33:42 INFO - PROCESS | 21027 | [#11] stanford-crypto-ccm Cycles:10 Average:133.40 Median:134.50 stddev:12.30 (9.1%) stddev-sans-first:12.83 15:33:42 INFO - PROCESS | 21027 | Values: 127.0 125.0 141.0 125.0 122.0 138.0 133.0 136.0 163.0 124.0 15:33:42 INFO - PROCESS | 21027 | 15:33:42 INFO - PROCESS | 21027 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.20 Median:165.50 stddev:2.44 (1.5%) stddev-sans-first:2.50 15:33:42 INFO - PROCESS | 21027 | Values: 167.0 164.0 167.0 164.0 165.0 164.0 164.0 170.0 161.0 166.0 15:33:42 INFO - PROCESS | 21027 | 15:33:42 INFO - PROCESS | 21027 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:67.00 stddev:1.40 (2.1%) stddev-sans-first:1.45 15:33:42 INFO - PROCESS | 21027 | Values: 67.0 65.0 67.0 68.0 67.0 64.0 65.0 68.0 65.0 66.0 15:33:42 INFO - PROCESS | 21027 | -------- Summary: end -------- 15:33:42 INFO - PROCESS | 21027 | 15:33:42 INFO - PROCESS | 21027 | 15:33:42 INFO - PROCESS | 21027 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 15:33:42 INFO - PROCESS | 21027 | 15:33:42 INFO - PROCESS | 21027 | 15:33:42 INFO - PROCESS | 21027 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 15:33:42 INFO - PROCESS | 21027 | 15:33:42 INFO - PROCESS | 21027 | 15:33:42 INFO - PROCESS | 21027 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 15:33:42 INFO - PROCESS | 21027 | 15:33:42 INFO - PROCESS | 21027 | 15:33:42 INFO - PROCESS | 21027 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000B,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 15:33:42 INFO - PROCESS | 21027 | 15:33:42 INFO - PROCESS | 21027 | 15:33:42 INFO - PROCESS | 21027 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 15:33:42 INFO - PROCESS | 21027 | 15:33:43 INFO - TEST-INFO | 21027: exit 0 15:33:43 INFO - TEST-OK | kraken | took 62651ms 15:33:43 INFO - SUITE-END | took 1176s 15:33:44 INFO - Completed test suite (00:19:37) 15:33:44 INFO - javascript benchmark 15:33:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7143.350462633368, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3016.3665630217656, 3045.649750278716, 3057.143999680089, 3074.062410964655, 3085.660577336493, 5277.947220527793, 5281.603879709028, 5323.307969963909, 5339.878625488652, 5467.17992301155, 5357.08929481988, 5414.214938833867, 5434.347878254605, 5440.619156659035, 5510.669359838413, 4869.5130486951375, 4948.2824990376375, 4975.552200301972, 5002.299678045077, 5034.697918124906, 4965.553100220979, 4980.9252861207115, 4989.950100498985, 4997.175466048097, 5001.649884508086, 4807.326974223612, 4826.1795494765975, 4849.806007759686, 4920.3111564381015, 4991.425986011619, 4827.951720482821, 4866.853994380174, 4880.463149053601, 4922.089413458486, 4932.457429682732, 4810.374651295309, 4860.100881336929, 4879.048585525824, 4889.779959901813, 4909.361782968192, 5276.525112739833, 5308.522232999048, 5324.1215199492035, 5326.2543243945875, 5406.351237851443, 5660.264165658479, 5690.943090569082, 5706.885862282731, 5715.3998830122655, 5715.828525144252, 5704.1443783432405, 5734.025215713297, 5830.941690583082, 5831.620944638585, 5832.125181222808, 5277.577793776489, 5404.1083221268445, 5409.6754194747655, 5435.42927992563, 5447.0, 5749.942500574941, 5752.28096487939, 5800.39095894925, 5803.5357171426185, 5869.735861886225, 5504.91742623861, 5572.916406253909, 5573.470520300565, 5578.860528486739, 5589.944100558942, 5649.6327738696855, 5649.774009039593, 5676.375598684142, 5711.200431939532, 5793.073108302736, 5777.45114214149, 5784.88430231393, 5798.362180160179, 5826.912596311059, 5828.504577110908, 5768.0, 5780.768769249267, 5784.652920824764, 5790.565707571949, 5812.070068788974, 4269.509006464296, 4300.677449191323, 4300.6989510734575, 4363.869083927487, 4417.491988421372, 3874.1864208515963, 3898.863539776094, 3942.48747662802, 3956.485656864589, 3977.801109944491, 5423.674579525241, 5493.615446918678, 5502.889942201214, 5511.917321240185, 5524.281843360418, 5663.745131469093, 5727.3699893011735, 5812.273465816773, 5822.7962021329895, 5845.0, 5428.077226871442, 5452.40023597404, 5460.208269800856, 5488.945110548843, 5557.0, 4777.737224452619, 4800.3759511263315, 4813.879653008633, 4830.3237546743485, 4857.295692124622, 5879.559033072622, 5963.777425627736, 5963.7912673056235, 5965.642061476326, 5990.580659353891, 5740.225069615715, 5760.567957403127, 5765.048766953406, 5790.884182316246, 5886.23478947734, 5962.284525856925, 5972.611780234271, 5994.580379373577, 5997.3402925677265, 6016.518678505797, 5636.718164091697, 5671.347795003628, 5690.5163061140265, 5710.486056254957, 5715.2855893013375, 5776.277965254343, 5823.8835223294445, 5845.09401042839, 5848.824535263949, 5881.588288819741, 5656.519195868397, 5677.971610142088, 5688.914666280092, 5695.829125126253, 5699.8860022800145, 5616.747246373841, 5695.629784064188, 5706.80026199081, 5710.914336284876, 5711.086226203787, 5452.890942181213, 5500.147477141049, 5516.14499752539, 5555.22226888244, 5572.804951826666, 5746.597738158289, 5770.769169233184, 5773.047447171338, 5774.422557744192, 5787.884242315215, 5583.776648933997, 5622.606417550732, 5655.377908429987, 5657.236273103243, 5662.716864156858], "value": 5308.991085982177, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.5432480482337, 580.6516090345793, 581.8981678206313, 582.4699523433676, 609.448449153516, 43921.0, 45562.08875822482, 45586.544134558724, 45615.31577026339, 45683.31475027873, 42504.57495425045, 42718.14563708724, 43001.13997720044, 43040.0, 43271.35092973608, 8852.8672069919, 8864.0, 8994.055624159468, 9017.95491022544, 9021.729348119534, 8472.110428405022, 8526.616302266382, 8556.61495232716, 8561.101084386144, 8566.700165494209, 8602.0, 8642.30861531079, 8665.523396213206, 8670.479771213715, 8690.435121717068, 8854.778630534289, 8873.645054197825, 8888.60001299943, 8904.777380565505, 8924.910750892474, 8754.518501482416, 8769.429987050822, 8814.603342849523, 8840.762293278945, 8889.155530224618, 40722.79638601818, 41231.38152927708, 41269.58730412687, 41314.586854131376, 41783.582164178275, 3355.234035780548, 3450.413429716929, 3588.3899737044767, 3750.0124933785137, 3992.9635885698212, 30950.380992380025, 31364.843175784205, 31384.843075784476, 31406.842965785254, 31494.803357445995, 4216.831326746927, 4277.807498662568, 4461.196984542781, 4467.0, 4474.418325617681, 313495.0, 313985.0, 314366.0, 315096.0, 315800.0, 44819.0, 44837.77581112139, 44847.327290090674, 44871.77564112159, 45108.77445612751, 31310.68689313123, 32073.0, 32105.197370065936, 33647.831760841036, 33779.662203378146, 14510.782338264935, 14677.486287980082, 14703.338349774285, 14754.778678319833, 14774.704505909822, 10829.0, 10845.295055821347, 10878.891211087788, 10941.671749847517, 11152.498137583829, 18242.45272641823, 18262.726059109125, 18272.725909111374, 18274.45176644703, 18369.81630183708, 6889.414399776075, 6916.896246556305, 7000.92999070013, 7088.610126443095, 7143.24995875436, 777.9494332868345, 854.7093689296283, 922.4050487435567, 967.5887747707196, 974.498133461268, 26961.0, 28476.430471390457, 28745.28136796555, 28897.42205155885, 28974.565381519293, 941.0495399646406, 963.2246041936169, 972.4943029624555, 996.6760802739138, 997.4165113408737, 14297.356618952172, 16605.83394166067, 17259.654806903793, 17380.65238695219, 18051.909740451476, 540080.0, 540909.0, 542881.0, 543790.0, 545501.0, 56160.43839561634, 56684.71657641685, 56701.43298567044, 56731.43268567262, 56970.43029569651, 1175.7295821960997, 1286.9356532173354, 1332.7134666046848, 1338.9489250938161, 1353.4586165533865, 29457.263568410963, 31146.0, 31883.52174717335, 32032.35935281328, 32363.676363236067, 43165.3525197116, 43719.56280437282, 43800.780996094814, 44029.0, 44062.55937440713, 371743.0, 371750.0, 373213.0, 373900.0, 497076.0, 24412.145574904793, 24429.755702443457, 24456.877715611306, 24575.0, 24587.754122458547, 37456.81271593733, 37777.05557361088, 38097.80951095227, 38301.233975320894, 38553.80723096366, 32657.0, 32804.0, 32842.83578582092, 33214.0, 33250.33499330048, 37658.2468350626, 37858.0, 38050.2389952205, 38791.80604096961, 40019.199616008096, 28820.423591527633, 29312.120636380943, 36602.26795464129, 38137.23725525529, 39483.40774888321, 32131.51802723008, 34714.48711667467, 35028.9491315261, 35354.82322588371, 35461.46807797936, 26343.736562634127, 27115.72884271132, 27187.86406067957, 27260.72739272661, 27388.58917116205], "value": 18473.549230494627, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.4420973180192, 378.8408868275324, 384.97112716546246, 394.33160792456795, 401.3237694484793, 17517.124143792822, 19657.115429805657, 20030.699539506903, 20096.59806803865, 20153.798462015377, 16942.491725248263, 17162.0, 17527.82472175281, 17588.12059397028, 17597.91201043993, 5502.752376143083, 5525.585581081415, 5731.455511726379, 5736.885262294752, 5761.337446193678, 5575.163725441196, 5696.060150075233, 5696.800611978581, 5704.401037891003, 5705.058665320217, 5568.6658800472105, 5662.716864156796, 5666.065099258617, 5680.31836179657, 5698.772049118031, 5877.764889404419, 5958.0, 5982.521398288127, 5984.461398474136, 5986.610870293439, 5596.58025648078, 5714.428557144294, 5729.226554415184, 5739.684317362543, 5773.566982476289, 13657.931710341483, 13899.861001389958, 13982.230977296245, 16260.593485162966, 23167.3049808506, 2290.2900100968754, 2411.397150712322, 2761.3412228796838, 2761.792865535073, 2955.571442140899, 9612.375195612332, 10105.848412273821, 10393.37639741618, 10664.680059598224, 12910.289934053624, 1920.69268916974, 1952.4045166224296, 1972.5364539333245, 1974.4076776966997, 1993.9003049847595, 82144.58927705324, 83205.0, 83523.0, 84111.5794421024, 85383.57308213481, 10722.410267435365, 10791.136709063256, 11023.228374013903, 11121.55513779456, 11190.776184476264, 14929.70140597182, 15008.849911500745, 15029.173395463136, 15048.247587620575, 15146.318415671321, 6198.194234749544, 6205.131281620576, 6864.313568643096, 7541.472096953161, 7753.10839253493, 7082.256363081905, 7110.537815042006, 7281.745138920112, 7299.708011679473, 7316.0489136411925, 4519.846224940303, 4565.132624801277, 4661.207594708908, 4792.688475249168, 4872.293517440023, 1912.2924517928454, 1924.5669724311917, 1946.834519065867, 1950.629380417716, 2033.786452422504, 889.1863944490718, 997.2969056814928, 1002.7793885345212, 1010.8534262531891, 1012.5696578953915, 18406.35577754799, 19248.0, 19351.51621209481, 19797.60404791896, 20181.082797134248, 889.4529864133511, 937.4890684576922, 945.3902233059638, 954.4559601027348, 971.4025874087386, 10277.640282590222, 10484.362357782855, 10717.678469645924, 10815.322700849543, 10870.94374291596, 508176.0, 511777.0, 514904.0, 514940.0, 515889.0, 87086.0, 89095.0, 89263.0, 89898.55050724704, 90105.54947225221, 924.9306302027375, 951.4814426137772, 979.7746518300688, 980.7450062983532, 987.8468837330225, 16351.704593731261, 16748.41380551675, 16849.747253790956, 17016.31934722647, 17537.473875783748, 41189.0, 41709.79145104255, 41935.790321048196, 43602.56397435985, 44125.0, 55587.0, 57234.7138264306, 57263.141052885076, 57395.713021434625, 59101.0, 6210.782622608187, 8333.791655208668, 8506.574671266288, 8637.524936128322, 9099.454032758056, 12520.123591348882, 12728.299943502825, 12847.293398863152, 13037.804432933703, 13318.400671969592, 10764.892351076389, 10871.510782014986, 11190.94404527972, 11265.155113366367, 11737.941310293394, 10885.510152043336, 10968.17738669587, 11201.21591488588, 11216.775664486502, 11918.702032449259, 11005.449727513753, 11006.669799906016, 11262.211645184758, 11502.194846360675, 11559.30644161353, 8385.706500272461, 8581.699640512552, 8625.353098517511, 8744.431611945203, 8864.290856731575, 9810.558524866256, 11039.889601104207, 11641.0, 12018.0, 12124.696882578006], "value": 9006.532625445763, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1431.9069260498068, 1482.4440834686993, 1530.1048886401454, 1610.0742073307852, 1637.4514537629893, 7505.887411688829, 7751.302382785549, 8269.421140520159, 8815.911840881588, 8837.337199710024, 8362.205590468895, 8680.56597170142, 8682.348823838205, 8794.604242809073, 8812.206901378875, 2343.2501599488087, 2353.776391242829, 2367.846090004144, 2368.656544801003, 2376.192094687806, 2291.86248825071, 2301.8158547316257, 2331.1491305673394, 2331.557004169211, 2338.3569518382496, 2279.9772002280015, 2280.908763649452, 2281.155972290255, 2346.21401830387, 2360.9173678921243, 2264.53577016712, 2266.8866556672183, 2267.8979445924974, 2274.113095892595, 2292.0487997481027, 2291.7364503082194, 2302.24026071396, 2304.8271379646594, 2312.0405031911905, 2312.7802858728564, 8729.388942774009, 8801.603927823264, 8847.867281990711, 8868.733937981871, 8875.644974201025, 5199.922001169985, 5348.411674715778, 5348.679079255218, 5351.812686555991, 5354.41101478837, 3357.4555704376016, 3387.5426817379584, 3485.3203625293077, 3499.61504234534, 3574.571051473814, 1155.4915837031679, 1210.8849659282441, 1227.416976935957, 1233.2600439736086, 1234.1916044990546, 12070.215435996632, 12089.274643521505, 12101.93949030258, 12142.150049496538, 12192.57325993586, 4327.783610819446, 4549.499555048942, 4768.1417344878255, 4771.379720636295, 4776.09254241693, 10231.079202871777, 10269.691909242734, 10275.383476991405, 10281.845772313422, 10285.22860785444, 5248.396434410091, 5310.468953104659, 5341.092014357491, 5342.6260161788305, 5351.919721204185, 4405.7797110145, 4598.839040633628, 4772.451168115642, 4887.266909963534, 4892.608591312686, 3838.328292548793, 3843.7309388342546, 3955.3473676843, 3956.7032472564674, 4022.4770779798437, 1245.588955644635, 1269.955551555691, 1272.6818295426144, 1274.9681257968439, 1289.8839104480642, 782.2568559868148, 853.7950891785927, 857.0957639690187, 876.2420506262038, 940.7977284883783, 5420.566354691615, 5591.860203494945, 5613.887722245532, 5902.085176797603, 5997.8707558815995, 868.1708967935606, 939.7650587353162, 951.1819834941945, 986.9703908882746, 1032.318669678009, 3837.136644255076, 3969.7816620085596, 3972.7020473464604, 4069.2878746219885, 4074.1851629674184, 10721.83917241242, 10991.945040274748, 11092.33445993243, 11097.83353249702, 11103.611373601885, 10882.564697412174, 10922.235443518877, 10933.18001149917, 10975.780484390427, 10976.451177441097, 7626.504277221963, 7935.0, 7987.081485629227, 7991.8401631967035, 8191.303739182117, 5660.433956604306, 5828.825135245949, 5876.853078673067, 5910.527157827278, 5939.168516407793, 9595.808083838423, 9783.853242201514, 9809.950950245204, 9880.308378413441, 9948.751281218027, 9377.906220937975, 9524.380915240487, 9551.235901128031, 10023.749406264902, 10170.949145254226, 6550.705218265094, 7370.262973702587, 7403.1486379064945, 7404.703811847466, 7515.286047825448, 8262.545559994258, 8394.160583941557, 8398.496090234605, 8400.033996090528, 8405.453645513022, 7507.699692012258, 7615.791420487996, 7751.9612401939885, 7828.373730101464, 7830.569318687527, 7349.77950661481, 7412.0, 7448.329650331496, 7475.588842613491, 7790.065192176975, 6705.195376554844, 6895.103636527219, 6931.584104953719, 6939.4795390346935, 6957.851954427463, 5105.642605017613, 5145.845624631267, 5175.094358487325, 5354.063038968087, 5412.134058550613, 5099.1331473648825, 5152.3044389007, 5190.870228244324, 5245.082110630548, 5302.621318457152], "value": 4592.169917724848, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.1869404529744, 336.5591075690845, 338.43312451643493, 351.2658543643784, 352.10916381554676, 5522.22688823564, 5545.474994376548, 5554.4167862374425, 5579.9163012554745, 5581.274434323543, 5440.537554307879, 5441.428649991753, 5487.134374312733, 5490.588205884555, 5500.532454741352, 4027.295223335912, 4145.3574695922025, 4202.873913782591, 4276.4440622719, 4325.372820940962, 4271.508776490697, 4281.464816897887, 4281.807318670667, 4284.335927931175, 4314.395984562164, 4250.468691413574, 4261.21167583998, 4263.531011588722, 4276.144771045788, 4288.485381754178, 4029.2545879012478, 4211.378619231587, 4265.765382903939, 4288.370419240699, 4301.139772045603, 3721.0511319613597, 3726.6832319252894, 3730.8880733578035, 3732.7387082904206, 3753.230587729536, 5386.730663466811, 5413.729313534308, 5428.185772134172, 5432.972835135839, 5448.346198456211, 4617.699849509771, 4900.607951363882, 4900.950990490085, 4930.852074437773, 4931.802727890916, 5653.897489989454, 5700.603352178701, 5706.400827913051, 5725.713714314267, 5744.167095771131, 4117.938230926538, 4132.318167502359, 4137.441445404862, 4140.834366625331, 4154.688398370135, 5931.970340148315, 5940.6435613863305, 5986.2217911671205, 6055.424734650202, 6081.756729730805, 4177.603127702924, 4201.45381100455, 4201.747895126302, 4229.598188172119, 4237.343211802176, 4258.488981322261, 4265.97867010663, 4272.081502476983, 4277.2087163874785, 4297.076128632359, 4677.883052923636, 4816.301636262722, 4859.271109333628, 4869.756512174448, 4886.682365646222, 5714.914276285859, 5734.311882574118, 5735.397783232784, 5748.48263656273, 5748.683822389725, 1468.860458256464, 1474.5944865161953, 1476.143836574784, 1485.9108453492825, 1496.880249580031, 910.8087301666592, 932.9720108396623, 954.8710924025306, 969.1713584884963, 977.2719324103447, 5492.857785463672, 5632.774689012475, 5639.548836093103, 5647.237622920935, 5651.802186923438, 5981.700914954235, 5999.820005399845, 6001.12983617373, 6012.917674818575, 6044.065898912306, 5377.865553361119, 5556.222128901876, 5580.400641586154, 5619.915701264485, 5701.372848986608, 3062.923426914345, 3099.1632259289863, 3109.595752552154, 3142.245860993345, 3146.348167212232, 5953.136795164677, 6072.483838873745, 6126.693665316717, 6129.295131059896, 6129.693515324216, 5936.614120082181, 5989.9101513477335, 5996.850078747979, 6001.5798894077, 6003.969980150071, 6100.420460056288, 6125.387461253839, 6127.050307202391, 6173.969130154321, 6177.96911015451, 5738.8278351649515, 5788.971055144697, 5791.189233507396, 5839.7372118255635, 5930.199423077829, 5778.2376375204285, 5821.94178058214, 5876.706164691663, 5879.559033072622, 5884.941150588611, 5944.762209511571, 5982.623996480746, 6080.3615620361, 6111.5110791137495, 6139.789675716827, 4179.477565304337, 4181.770002649883, 4197.286461301647, 4229.0, 4230.217409779078, 5898.849724303891, 5927.798988546137, 5968.820935371946, 5968.8806223876145, 5993.0710739835395, 5515.007298686275, 5746.827595172152, 5752.165935939349, 5754.53963682896, 5823.679697616672, 5710.514606258348, 5743.851229754149, 5754.56840736938, 5769.643918841248, 5783.508401785895, 5522.5858060644805, 5678.574106942078, 5692.861427714556, 5718.225970859213, 5721.771129154788, 5782.826515204551, 5834.883302334015, 5849.327327357409, 5852.741660542833, 5857.619254748428, 5710.371859095413, 5733.226014487991, 5754.68349240779, 5754.856128596819, 5797.739101740347], "value": 4393.136116717057, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [715.4097869257863, 727.9745208917687, 762.9313361797441, 767.3362541401689, 820.421602770047, 15179.924100379496, 16017.439389621366, 16034.83965160348, 16095.356185752556, 16164.919175404137, 14968.25158742064, 15138.621534461616, 15181.77227341588, 15199.164045977466, 15202.315895784688, 645.8901986662279, 654.0614218596306, 763.1109757132933, 765.8430021845522, 790.083503136362, 782.2451334462243, 785.5522352259214, 787.6691789448416, 793.8452001859611, 797.7526966640331, 838.7022606974527, 844.307667712476, 845.720912099009, 847.2628812932758, 850.0691742541907, 832.650286879506, 839.6095815445847, 843.7637461510786, 845.327964268405, 845.5603086395071, 614.5390956782413, 614.8493619063358, 615.4153554123601, 617.478230894893, 619.1764952613014, 14347.0, 14347.497837575738, 14399.136051836818, 14429.989900706954, 14450.205238711867, 14274.714505709828, 14323.498677546237, 14425.639359016004, 14634.926825365912, 14788.40846366144, 11783.351915644636, 11879.584214552535, 11880.227785193934, 11903.285802851857, 12511.249325040435, 3670.724695647837, 3756.1683889091278, 3814.141818090935, 3835.0987517933263, 3926.9410958835642, 81859.5907020467, 82256.0, 83448.0, 83483.0, 83486.58256708739, 9566.856497152548, 9644.421334719938, 9803.522799986207, 9829.22409532704, 9936.50317484123, 20315.390538283875, 20342.0, 20573.79426205719, 20577.279795207094, 20620.587588248152, 8163.79590510242, 8237.917620823835, 8241.670333186605, 8246.8350632987, 8272.875906861402, 4410.25025745624, 4504.707194032378, 4513.210188217049, 4540.704854184468, 4653.813847446132, 3737.3459644562095, 3836.0793409582056, 3843.6540711336115, 3857.72995890285, 3872.7482713623526, 581.5086252116954, 617.6664601115438, 624.8406656302705, 636.901280301554, 684.3498676257575, 636.7675798333574, 675.5068799776093, 696.895465680152, 711.1679335177854, 712.9857402851914, 9740.46427446483, 9844.0, 10119.7470063249, 10125.0, 10356.430396328124, 582.4612233683825, 645.3739872323838, 688.8725585766649, 713.2403989750899, 725.0900120348929, 4449.755263460476, 4658.650601204923, 4746.59653929413, 4812.5081224820415, 4821.456075760029, 73195.0, 74552.62723686347, 126846.0, 130959.0, 131582.0, 107632.46183769031, 110539.0, 110586.0, 111537.0, 112210.43894780474, 60044.0, 87864.5606771962, 97569.0, 97811.0, 104128.0, 8825.38222324431, 9168.633254670005, 9361.204297634777, 9415.717528474157, 9469.0, 56136.719316403156, 56223.0, 57185.0, 57822.0, 59218.0, 76452.61773691096, 83644.58177709073, 85388.0, 87405.56297218728, 90165.0, 11555.711107222387, 11744.647660570197, 11798.410079496163, 11914.285142891455, 12279.631611051684, 13271.203727776365, 13524.391402387113, 13723.099067401114, 13732.862671373558, 13912.60424301245, 12793.360331983178, 12987.440519537615, 13223.206607603575, 13529.2558909257, 13956.930215348859, 12397.566085186974, 12424.440900159696, 12464.688382790502, 12600.866873065015, 12608.0, 12638.2417054977, 12684.365781710692, 13056.412461439448, 13166.025096235642, 13414.932925335312, 10213.489325533843, 10272.589096436059, 10364.896351036394, 10469.895301046892, 10755.462226888782, 9949.701508954742, 10510.737231569272, 10527.4736263185, 10546.947265263932, 10589.152867770406], "value": 7455.190559788505, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1509.7000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 116.0, 115.0, 115.0, 114.0, 113.0, 115.0, 112.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 121.0, 122.0, 177.0, 131.0, 120.0, 120.0, 121.0, 159.0, 121.0], "value": 133.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 165.0, 168.0, 166.0, 167.0, 166.0, 161.0, 164.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 77.0, 111.0, 77.0, 79.0, 76.0, 76.0, 99.0, 77.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 115.0, 83.0, 87.0, 83.0, 97.0, 84.0, 83.0, 118.0], "value": 91.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 118.0, 118.0, 118.0, 118.0, 117.0, 118.0, 118.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 149.0, 147.0, 147.0, 154.0, 147.0, 146.0, 146.0, 148.0, 149.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 97.0, 95.0, 96.0, 95.0, 97.0, 96.0, 96.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 56.0, 51.0, 61.0, 58.0, 53.0, 53.0, 51.0, 59.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 60.0, 61.0, 62.0, 60.0, 61.0, 60.0, 61.0, 62.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 87.0, 81.0, 80.0, 79.0, 79.0, 79.0, 82.0, 80.0, 79.0], "value": 80.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 125.0, 141.0, 125.0, 122.0, 138.0, 133.0, 136.0, 163.0, 124.0], "value": 133.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 164.0, 167.0, 164.0, 165.0, 164.0, 164.0, 170.0, 161.0, 166.0], "value": 165.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 67.0, 68.0, 67.0, 64.0, 65.0, 68.0, 65.0, 66.0], "value": 66.2, "unit": "score"}]}]} 15:33:44 INFO - Return code: 0 15:33:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:33:44 ERROR - # TBPL SUCCESS # 15:33:44 INFO - Running post-action listener: _resource_record_post_action 15:33:44 INFO - [mozharness: 2016-09-23 22:33:44.187084Z] Finished run-tests step (success) 15:33:44 INFO - Running post-run listener: _resource_record_post_run 15:33:44 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 8192; Write bytes: 409313280; Read time: 112; Write time: 301680 15:33:44 INFO - TinderboxPrint: CPU usage
13.4% 15:33:44 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 112 15:33:44 INFO - TinderboxPrint: I/O write bytes / time
409,313,280 / 301,680 15:33:44 INFO - TinderboxPrint: CPU idle
8,254.2 (86.6%) 15:33:44 INFO - TinderboxPrint: CPU user
1,214.3 (12.7%) 15:33:44 INFO - TinderboxPrint: Swap in / out
0 / 0 15:33:44 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103911424; Read time: 0; Write time: 101676 15:33:44 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288571392; Read time: 96; Write time: 194344 15:33:44 INFO - Running post-run listener: _upload_blobber_files 15:33:44 INFO - Blob upload gear active. 15:33:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:33:44 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 15:33:44 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'] 15:33:44 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 15:33:45 INFO - (blobuploader) - INFO - Open directory for files ... 15:33:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:33:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:33:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:33:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:33:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:33:45 INFO - (blobuploader) - INFO - Done attempting. 15:33:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:33:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:33:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:33:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:33:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:33:50 INFO - (blobuploader) - INFO - Done attempting. 15:33:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:33:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:33:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:33:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:33:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:33:51 INFO - (blobuploader) - INFO - Done attempting. 15:33:51 INFO - (blobuploader) - INFO - Iteration through files over. 15:33:51 INFO - Return code: 0 15:33:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:33:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:33:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/51b55a0da3a08e5ffa8e928e3c903d4904155298aa7d5734f4ba949d02075f5abecaaff4a3b70601a902751118901236a5370a5eb3e951a08825cf4ec91372c0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e69c3b8e8c35100936a75c5456a3f9df68203049b1391bb055f234ff57960c8ae434657010dd839ac28bb2836aac01864189de1ea361ab7d0c04dd476788ee53", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/25a112d56e88ec56781e126df88765ae45049982d15959cb2497167412111b2a06e674b2d3919684bd6a29caf293888651228cafb18dc34e0c70b45f0977eb8c"} 15:33:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:33:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:33:51 INFO - Contents: 15:33:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/51b55a0da3a08e5ffa8e928e3c903d4904155298aa7d5734f4ba949d02075f5abecaaff4a3b70601a902751118901236a5370a5eb3e951a08825cf4ec91372c0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e69c3b8e8c35100936a75c5456a3f9df68203049b1391bb055f234ff57960c8ae434657010dd839ac28bb2836aac01864189de1ea361ab7d0c04dd476788ee53", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/25a112d56e88ec56781e126df88765ae45049982d15959cb2497167412111b2a06e674b2d3919684bd6a29caf293888651228cafb18dc34e0c70b45f0977eb8c"} 15:33:51 INFO - Running post-run listener: copy_logs_to_upload_dir 15:33:51 INFO - Copying logs to upload dir... 15:33:51 INFO - mkdir: /builds/slave/test/build/upload/logs 15:33:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.824852 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-09-23 15:33:51.128789) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 15:33:51.132057) ========= 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=a0d2d2de893abaa8702a9954000001a7-1474668657.787450-1777339813 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/51b55a0da3a08e5ffa8e928e3c903d4904155298aa7d5734f4ba949d02075f5abecaaff4a3b70601a902751118901236a5370a5eb3e951a08825cf4ec91372c0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e69c3b8e8c35100936a75c5456a3f9df68203049b1391bb055f234ff57960c8ae434657010dd839ac28bb2836aac01864189de1ea361ab7d0c04dd476788ee53", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/25a112d56e88ec56781e126df88765ae45049982d15959cb2497167412111b2a06e674b2d3919684bd6a29caf293888651228cafb18dc34e0c70b45f0977eb8c"} build_url:https://queue.taskcluster.net/v1/task/OTEjQE-xT-WQfasMLWtqeg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011386 build_url: 'https://queue.taskcluster.net/v1/task/OTEjQE-xT-WQfasMLWtqeg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/51b55a0da3a08e5ffa8e928e3c903d4904155298aa7d5734f4ba949d02075f5abecaaff4a3b70601a902751118901236a5370a5eb3e951a08825cf4ec91372c0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e69c3b8e8c35100936a75c5456a3f9df68203049b1391bb055f234ff57960c8ae434657010dd839ac28bb2836aac01864189de1ea361ab7d0c04dd476788ee53", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/25a112d56e88ec56781e126df88765ae45049982d15959cb2497167412111b2a06e674b2d3919684bd6a29caf293888651228cafb18dc34e0c70b45f0977eb8c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 15:33:51.157040) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 15:33:51.157341) ========= 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=a0d2d2de893abaa8702a9954000001a7-1474668657.787450-1777339813 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004480 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 15:33:51.239487) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 15:33:51.242844) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 15:33:51.243171) ========= ========= Total master_lag: 0.21 =========