builder: autoland_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-064 starttime: 1473812250.32 results: success (0) buildid: 20160913153006 builduid: f40d7f6aa4c649bfaf15fbfb0adb33a4 revision: cec9f17302dbc776fa3a43c3a3c81e7fee873f0f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-13 17:17:30.321321) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-13 17:17:30.321790) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-13 17:17:30.322072) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-13 17:17:30.336580) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 17:17:30.336955) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1473812252.13557-2082194890 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-13 17:17:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 17.0M=0.001s 2016-09-13 17:17:32 (17.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098707 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 17:17:30.449603) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 17:17:30.449942) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1473812252.13557-2082194890 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014195 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 17:17:30.499979) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 17:17:30.500381) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev cec9f17302dbc776fa3a43c3a3c81e7fee873f0f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev cec9f17302dbc776fa3a43c3a3c81e7fee873f0f --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=a12cd81e0ef515edd9e0d800000001bb-1473812252.13557-2082194890 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-13 17:17:32,913 truncating revision to first 12 chars 2016-09-13 17:17:32,913 Setting DEBUG logging. 2016-09-13 17:17:32,913 attempt 1/10 2016-09-13 17:17:32,913 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/cec9f17302db?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-13 17:17:33,236 unpacking tar archive at: autoland-cec9f17302db/testing/mozharness/ program finished with exit code 0 elapsedTime=0.665928 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 17:17:31.180234) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-13 17:17:31.180567) ========= script_repo_revision: cec9f17302dbc776fa3a43c3a3c81e7fee873f0f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-13 17:17:31.180974) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-13 17:17:31.181250) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-13 17:17:31.191636) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-09-13 17:17:31.192164) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] 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=a12cd81e0ef515edd9e0d800000001bb-1473812252.13557-2082194890 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:17:33 INFO - MultiFileLogger online at 20160913 17:17:33 in /builds/slave/test 17:17:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 17:17:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:17:33 INFO - {'append_to_log': False, 17:17:33 INFO - 'base_work_dir': '/builds/slave/test', 17:17:33 INFO - 'blob_upload_branch': 'Autoland', 17:17:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:17:33 INFO - 'branch': 'Autoland', 17:17:33 INFO - 'buildbot_json_path': 'buildprops.json', 17:17:33 INFO - 'config_files': ('talos/linux_config.py',), 17:17:33 INFO - 'default_actions': ('clobber', 17:17:33 INFO - 'read-buildbot-config', 17:17:33 INFO - 'download-and-extract', 17:17:33 INFO - 'populate-webroot', 17:17:33 INFO - 'create-virtualenv', 17:17:33 INFO - 'install', 17:17:33 INFO - 'run-tests'), 17:17:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:17:33 INFO - 'download_minidump_stackwalk': True, 17:17:33 INFO - 'download_symbols': 'ondemand', 17:17:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:17:33 INFO - 'tooltool.py': '/tools/tooltool.py', 17:17:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:17:33 INFO - '/tools/misc-python/virtualenv.py')}, 17:17:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:17:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:17:33 INFO - 'installer_path': 'installer.exe', 17:17:33 INFO - 'log_level': 'info', 17:17:33 INFO - 'log_name': 'talos', 17:17:33 INFO - 'log_to_console': True, 17:17:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:17:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:17:33 INFO - 'opt_config_files': (), 17:17:33 INFO - 'pip_index': False, 17:17:33 INFO - 'sps_profile': False, 17:17:33 INFO - 'sps_profile_interval': 0, 17:17:33 INFO - 'suite': 'dromaeojs', 17:17:33 INFO - 'system_bits': '32', 17:17:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:17:33 INFO - 'title': 'talos-linux64-ix-064', 17:17:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:17:33 INFO - 'use_talos_json': True, 17:17:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:17:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:17:33 INFO - 'work_dir': 'build'} 17:17:33 INFO - [mozharness: 2016-09-14 00:17:33.697255Z] Running clobber step. 17:17:33 INFO - Running pre-action listener: _resource_record_pre_action 17:17:33 INFO - Running main action method: clobber 17:17:33 INFO - rmtree: /builds/slave/test/build 17:17:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:17:34 INFO - Running post-action listener: _resource_record_post_action 17:17:34 INFO - [mozharness: 2016-09-14 00:17:34.158090Z] Finished clobber step (success) 17:17:34 INFO - [mozharness: 2016-09-14 00:17:34.158193Z] Running read-buildbot-config step. 17:17:34 INFO - Running pre-action listener: _resource_record_pre_action 17:17:34 INFO - Running main action method: read_buildbot_config 17:17:34 INFO - Using buildbot properties: 17:17:34 INFO - { 17:17:34 INFO - "project": "", 17:17:34 INFO - "product": "firefox", 17:17:34 INFO - "script_repo_revision": "production", 17:17:34 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 17:17:34 INFO - "repository": "", 17:17:34 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs", 17:17:34 INFO - "buildid": "20160913153006", 17:17:34 INFO - "pgo_build": "True", 17:17:34 INFO - "basedir": "/builds/slave/test", 17:17:34 INFO - "buildnumber": 196, 17:17:34 INFO - "slavename": "talos-linux64-ix-064", 17:17:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:17:34 INFO - "platform": "ubuntu64_hw", 17:17:34 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 17:17:34 INFO - "branch": "autoland", 17:17:34 INFO - "repo_path": "integration/autoland", 17:17:34 INFO - "revision": "cec9f17302dbc776fa3a43c3a3c81e7fee873f0f", 17:17:34 INFO - "stage_platform": "linux64-pgo", 17:17:34 INFO - "builduid": "f40d7f6aa4c649bfaf15fbfb0adb33a4", 17:17:34 INFO - "slavebuilddir": "test" 17:17:34 INFO - } 17:17:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/JuthdzfDSpSbZctGsn6BlA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 17:17:34 INFO - Running post-action listener: _resource_record_post_action 17:17:34 INFO - [mozharness: 2016-09-14 00:17:34.160651Z] Finished read-buildbot-config step (success) 17:17:34 INFO - [mozharness: 2016-09-14 00:17:34.160740Z] Running download-and-extract step. 17:17:34 INFO - Running pre-action listener: _resource_record_pre_action 17:17:34 INFO - Running main action method: download_and_extract 17:17:34 INFO - mkdir: /builds/slave/test/build/tests 17:17:34 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')]} 17:17:34 INFO - trying https://queue.taskcluster.net/v1/task/JuthdzfDSpSbZctGsn6BlA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 17:17:34 INFO - Downloading https://queue.taskcluster.net/v1/task/JuthdzfDSpSbZctGsn6BlA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 17:17:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JuthdzfDSpSbZctGsn6BlA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:17:34 INFO - Downloaded 1361 bytes. 17:17:34 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 17:17:34 INFO - Using the following test package requirements: 17:17:34 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 17:17:34 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:17:34 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:17:34 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:34 INFO - u'jsshell-linux-x86_64.zip'], 17:17:34 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:17:34 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 17:17:34 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:17:34 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:17:34 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:17:34 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:17:34 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:17:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JuthdzfDSpSbZctGsn6BlA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:17:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JuthdzfDSpSbZctGsn6BlA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:17:34 INFO - Fetch https://queue.taskcluster.net/v1/task/JuthdzfDSpSbZctGsn6BlA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip into memory 17:17:35 INFO - Expected file size: 21932307 17:17:39 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:17:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JuthdzfDSpSbZctGsn6BlA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:17:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JuthdzfDSpSbZctGsn6BlA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:17:39 INFO - Fetch https://queue.taskcluster.net/v1/task/JuthdzfDSpSbZctGsn6BlA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip into memory 17:17:40 INFO - Expected file size: 21932307 17:17:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JuthdzfDSpSbZctGsn6BlA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 17:17:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JuthdzfDSpSbZctGsn6BlA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:17:44 INFO - Fetch https://queue.taskcluster.net/v1/task/JuthdzfDSpSbZctGsn6BlA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip into memory 17:17:45 INFO - Expected file size: 14414048 17:17:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:46 INFO - trying https://queue.taskcluster.net/v1/task/JuthdzfDSpSbZctGsn6BlA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:17:46 INFO - Downloading https://queue.taskcluster.net/v1/task/JuthdzfDSpSbZctGsn6BlA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:17:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JuthdzfDSpSbZctGsn6BlA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:17:47 INFO - Downloaded 59587221 bytes. 17:17:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JuthdzfDSpSbZctGsn6BlA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:17:47 INFO - mkdir: /builds/slave/test/properties 17:17:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:17:47 INFO - Writing to file /builds/slave/test/properties/build_url 17:17:47 INFO - Contents: 17:17:47 INFO - build_url:https://queue.taskcluster.net/v1/task/JuthdzfDSpSbZctGsn6BlA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:17:47 INFO - Running post-action listener: _resource_record_post_action 17:17:47 INFO - Running post-action listener: set_extra_try_arguments 17:17:47 INFO - [mozharness: 2016-09-14 00:17:47.822751Z] Finished download-and-extract step (success) 17:17:47 INFO - [mozharness: 2016-09-14 00:17:47.822979Z] Running populate-webroot step. 17:17:47 INFO - Running pre-action listener: _resource_record_pre_action 17:17:47 INFO - Running main action method: populate_webroot 17:17:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:17:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:17:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:17:47 INFO - '--tppagecycles', 17:17:47 INFO - '7'], 17:17:47 INFO - 'tests': ['tsvgm']}}, 17:17:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:17:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:17:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:17:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:17:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:17:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:17:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:47 INFO - 'talos_options': ['--disable-e10s'], 17:17:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:17:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:17:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:47 INFO - 'talos_options': ['--disable-e10s'], 17:17:47 INFO - 'tests': ['damp', 'tps']}, 17:17:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:47 INFO - 'tests': ['damp', 'tps']}, 17:17:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:17:47 INFO - 'tests': ['dromaeo_dom']}, 17:17:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:17:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:17:47 INFO - 'tests': ['basic_compositor_video']}, 17:17:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:17:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:17:47 INFO - 'tests': ['a11yr', 17:17:47 INFO - 'ts_paint', 17:17:47 INFO - 'tpaint', 17:17:47 INFO - 'sessionrestore', 17:17:47 INFO - 'sessionrestore_no_auto_restore', 17:17:47 INFO - 'tabpaint']}, 17:17:47 INFO - 'other-e10s': {'tests': ['a11yr', 17:17:47 INFO - 'ts_paint', 17:17:47 INFO - 'tpaint', 17:17:47 INFO - 'sessionrestore', 17:17:47 INFO - 'sessionrestore_no_auto_restore', 17:17:47 INFO - 'tabpaint']}, 17:17:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:17:47 INFO - 'ts_paint', 17:17:47 INFO - 'tpaint', 17:17:47 INFO - 'sessionrestore', 17:17:47 INFO - 'sessionrestore_no_auto_restore', 17:17:47 INFO - 'tabpaint']}, 17:17:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:17:47 INFO - 'ts_paint', 17:17:47 INFO - 'tpaint', 17:17:47 INFO - 'sessionrestore', 17:17:47 INFO - 'sessionrestore_no_auto_restore', 17:17:47 INFO - 'tabpaint']}, 17:17:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:17:47 INFO - 'tests': ['a11yr', 17:17:47 INFO - 'ts_paint', 17:17:47 INFO - 'tpaint', 17:17:47 INFO - 'sessionrestore', 17:17:47 INFO - 'sessionrestore_no_auto_restore', 17:17:47 INFO - 'tabpaint']}, 17:17:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:17:47 INFO - 'tests': ['a11yr', 17:17:47 INFO - 'ts_paint', 17:17:47 INFO - 'tpaint', 17:17:47 INFO - 'sessionrestore', 17:17:47 INFO - 'sessionrestore_no_auto_restore', 17:17:47 INFO - 'tabpaint']}, 17:17:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:17:47 INFO - 'tests': ['tsvgx', 17:17:47 INFO - 'tsvgr_opacity', 17:17:47 INFO - 'tart', 17:17:47 INFO - 'tscrollx', 17:17:47 INFO - 'cart']}, 17:17:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:17:47 INFO - 'tsvgr_opacity', 17:17:47 INFO - 'tart', 17:17:47 INFO - 'tscrollx', 17:17:47 INFO - 'cart']}, 17:17:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:47 INFO - 'talos_options': ['--disable-e10s'], 17:17:47 INFO - 'tests': ['tp5o']}, 17:17:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:47 INFO - 'tests': ['tp5o']}, 17:17:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:47 INFO - 'talos_options': ['--disable-e10s', 17:17:47 INFO - '--xperf_path', 17:17:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:17:47 INFO - 'tests': ['tp5n']}, 17:17:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:47 INFO - 'talos_options': ['--xperf_path', 17:17:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:17:47 INFO - 'tests': ['tp5n']}}, 17:17:47 INFO - 'talos.zip': {'path': '', 17:17:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:17:47 INFO - Running post-action listener: _resource_record_post_action 17:17:47 INFO - [mozharness: 2016-09-14 00:17:47.841123Z] Finished populate-webroot step (success) 17:17:47 INFO - [mozharness: 2016-09-14 00:17:47.841213Z] Running create-virtualenv step. 17:17:47 INFO - Running pre-action listener: _resource_record_pre_action 17:17:47 INFO - Running main action method: create_virtualenv 17:17:47 INFO - Creating virtualenv /builds/slave/test/build/venv 17:17:47 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 17:17:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:17:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:17:47 INFO - Using real prefix '/usr' 17:17:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:17:48 INFO - Installing distribute.............................................................................................................................................................................................done. 17:17:50 INFO - Installing pip.................done. 17:17:50 INFO - Return code: 0 17:17:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:17:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f374884ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b1a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba9790>, '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 0x2baa690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2baab20>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1473812252.13557-2082194890', '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 17:17:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:17:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:17:50 INFO - Using env: {'DISPLAY': ':0', 17:17:50 INFO - 'HOME': '/home/cltbld', 17:17:50 INFO - 'LANG': 'en_US.UTF-8', 17:17:50 INFO - 'LANGUAGE': 'en_US:en', 17:17:50 INFO - 'LOGNAME': 'cltbld', 17:17:50 INFO - 'MAIL': '/var/mail/cltbld', 17:17:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:50 INFO - 'MOZ_NO_REMOTE': '1', 17:17:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:50 INFO - 'NO_EM_RESTART': '1', 17:17:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:50 INFO - 'PWD': '/builds/slave/test', 17:17:50 INFO - 'SHELL': '/bin/bash', 17:17:50 INFO - 'SHLVL': '1', 17:17:50 INFO - 'TERM': 'linux', 17:17:50 INFO - 'TMOUT': '86400', 17:17:50 INFO - 'USER': 'cltbld', 17:17:50 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1473812252.13557-2082194890', 17:17:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:50 INFO - '_': '/tools/buildbot/bin/python'} 17:17:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:50 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 17:17:50 INFO - Cleaning up... 17:17:50 INFO - Return code: 0 17:17:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:17:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f374884ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b1a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba9790>, '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 0x2baa690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2baab20>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1473812252.13557-2082194890', '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 17:17:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:17:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:17:50 INFO - Using env: {'DISPLAY': ':0', 17:17:50 INFO - 'HOME': '/home/cltbld', 17:17:50 INFO - 'LANG': 'en_US.UTF-8', 17:17:50 INFO - 'LANGUAGE': 'en_US:en', 17:17:50 INFO - 'LOGNAME': 'cltbld', 17:17:50 INFO - 'MAIL': '/var/mail/cltbld', 17:17:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:50 INFO - 'MOZ_NO_REMOTE': '1', 17:17:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:50 INFO - 'NO_EM_RESTART': '1', 17:17:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:50 INFO - 'PWD': '/builds/slave/test', 17:17:50 INFO - 'SHELL': '/bin/bash', 17:17:50 INFO - 'SHLVL': '1', 17:17:50 INFO - 'TERM': 'linux', 17:17:50 INFO - 'TMOUT': '86400', 17:17:50 INFO - 'USER': 'cltbld', 17:17:50 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1473812252.13557-2082194890', 17:17:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:50 INFO - '_': '/tools/buildbot/bin/python'} 17:17:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:50 INFO - Downloading/unpacking psutil>=3.1.1 17:17:50 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 17:17:50 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 17:17:50 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 17:17:50 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 17:17:50 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 17:17:50 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 17:17:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:17:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:17:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:17:52 INFO - Installing collected packages: psutil 17:17:52 INFO - Running setup.py install for psutil 17:17:52 INFO - building 'psutil._psutil_linux' extension 17:17:52 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 17:17:53 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 17:17:53 INFO - building 'psutil._psutil_posix' extension 17:17:53 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 17:17:53 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 17:17:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:17:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:17:53 INFO - Successfully installed psutil 17:17:53 INFO - Cleaning up... 17:17:53 INFO - Return code: 0 17:17:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:17:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f374884ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b1a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba9790>, '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 0x2baa690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2baab20>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1473812252.13557-2082194890', '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 17:17:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:17:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:17:53 INFO - Using env: {'DISPLAY': ':0', 17:17:53 INFO - 'HOME': '/home/cltbld', 17:17:53 INFO - 'LANG': 'en_US.UTF-8', 17:17:53 INFO - 'LANGUAGE': 'en_US:en', 17:17:53 INFO - 'LOGNAME': 'cltbld', 17:17:53 INFO - 'MAIL': '/var/mail/cltbld', 17:17:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:53 INFO - 'MOZ_NO_REMOTE': '1', 17:17:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:53 INFO - 'NO_EM_RESTART': '1', 17:17:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:53 INFO - 'PWD': '/builds/slave/test', 17:17:53 INFO - 'SHELL': '/bin/bash', 17:17:53 INFO - 'SHLVL': '1', 17:17:53 INFO - 'TERM': 'linux', 17:17:53 INFO - 'TMOUT': '86400', 17:17:53 INFO - 'USER': 'cltbld', 17:17:53 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1473812252.13557-2082194890', 17:17:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:53 INFO - '_': '/tools/buildbot/bin/python'} 17:17:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:17:53 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 17:17:53 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 17:17:53 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 17:17:53 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 17:17:53 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 17:17:53 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 17:17:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:17:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:17:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:17:55 INFO - Installing collected packages: mozsystemmonitor 17:17:55 INFO - Running setup.py install for mozsystemmonitor 17:17:55 INFO - Successfully installed mozsystemmonitor 17:17:55 INFO - Cleaning up... 17:17:55 INFO - Return code: 0 17:17:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:17:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f374884ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b1a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba9790>, '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 0x2baa690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2baab20>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1473812252.13557-2082194890', '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 17:17:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:17:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:17:55 INFO - Using env: {'DISPLAY': ':0', 17:17:55 INFO - 'HOME': '/home/cltbld', 17:17:55 INFO - 'LANG': 'en_US.UTF-8', 17:17:55 INFO - 'LANGUAGE': 'en_US:en', 17:17:55 INFO - 'LOGNAME': 'cltbld', 17:17:55 INFO - 'MAIL': '/var/mail/cltbld', 17:17:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:55 INFO - 'MOZ_NO_REMOTE': '1', 17:17:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:55 INFO - 'NO_EM_RESTART': '1', 17:17:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:55 INFO - 'PWD': '/builds/slave/test', 17:17:55 INFO - 'SHELL': '/bin/bash', 17:17:55 INFO - 'SHLVL': '1', 17:17:55 INFO - 'TERM': 'linux', 17:17:55 INFO - 'TMOUT': '86400', 17:17:55 INFO - 'USER': 'cltbld', 17:17:55 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1473812252.13557-2082194890', 17:17:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:55 INFO - '_': '/tools/buildbot/bin/python'} 17:17:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:55 INFO - Downloading/unpacking jsonschema==2.5.1 17:17:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:17:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:58 INFO - Downloading functools32-3.2.3-2.tar.gz 17:17:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:17:58 INFO - warning: no files found matching '*.txt' 17:17:58 INFO - no previously-included directories found matching 'build' 17:17:58 INFO - no previously-included directories found matching 'dist' 17:17:58 INFO - no previously-included directories found matching '.git*' 17:17:58 INFO - Installing collected packages: jsonschema, functools32 17:17:58 INFO - Running setup.py install for functools32 17:17:58 INFO - warning: no files found matching '*.txt' 17:17:58 INFO - no previously-included directories found matching 'build' 17:17:58 INFO - no previously-included directories found matching 'dist' 17:17:58 INFO - no previously-included directories found matching '.git*' 17:17:58 INFO - Successfully installed jsonschema functools32 17:17:58 INFO - Cleaning up... 17:17:58 INFO - Return code: 0 17:17:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f374884ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b1a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba9790>, '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 0x2baa690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2baab20>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1473812252.13557-2082194890', '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 17:17:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:17:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:17:58 INFO - Using env: {'DISPLAY': ':0', 17:17:58 INFO - 'HOME': '/home/cltbld', 17:17:58 INFO - 'LANG': 'en_US.UTF-8', 17:17:58 INFO - 'LANGUAGE': 'en_US:en', 17:17:58 INFO - 'LOGNAME': 'cltbld', 17:17:58 INFO - 'MAIL': '/var/mail/cltbld', 17:17:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:58 INFO - 'MOZ_NO_REMOTE': '1', 17:17:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:58 INFO - 'NO_EM_RESTART': '1', 17:17:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:58 INFO - 'PWD': '/builds/slave/test', 17:17:58 INFO - 'SHELL': '/bin/bash', 17:17:58 INFO - 'SHLVL': '1', 17:17:58 INFO - 'TERM': 'linux', 17:17:58 INFO - 'TMOUT': '86400', 17:17:58 INFO - 'USER': 'cltbld', 17:17:58 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1473812252.13557-2082194890', 17:17:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:58 INFO - '_': '/tools/buildbot/bin/python'} 17:17:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:17:58 INFO - Cleaning up... 17:17:58 INFO - Return code: 0 17:17:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f374884ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b1a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba9790>, '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 0x2baa690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2baab20>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1473812252.13557-2082194890', '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 17:17:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:17:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:17:58 INFO - Using env: {'DISPLAY': ':0', 17:17:58 INFO - 'HOME': '/home/cltbld', 17:17:58 INFO - 'LANG': 'en_US.UTF-8', 17:17:58 INFO - 'LANGUAGE': 'en_US:en', 17:17:58 INFO - 'LOGNAME': 'cltbld', 17:17:58 INFO - 'MAIL': '/var/mail/cltbld', 17:17:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:58 INFO - 'MOZ_NO_REMOTE': '1', 17:17:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:58 INFO - 'NO_EM_RESTART': '1', 17:17:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:58 INFO - 'PWD': '/builds/slave/test', 17:17:58 INFO - 'SHELL': '/bin/bash', 17:17:58 INFO - 'SHLVL': '1', 17:17:58 INFO - 'TERM': 'linux', 17:17:58 INFO - 'TMOUT': '86400', 17:17:58 INFO - 'USER': 'cltbld', 17:17:58 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1473812252.13557-2082194890', 17:17:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:58 INFO - '_': '/tools/buildbot/bin/python'} 17:17:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:58 INFO - Downloading/unpacking blobuploader==1.2.4 17:17:58 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 17:17:58 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 17:17:58 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 17:17:58 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 17:17:58 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 17:17:58 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 17:18:00 INFO - Downloading blobuploader-1.2.4.tar.gz 17:18:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:18:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:18:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:18:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:01 INFO - Downloading docopt-0.6.1.tar.gz 17:18:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:18:01 INFO - Installing collected packages: blobuploader, requests, docopt 17:18:01 INFO - Running setup.py install for blobuploader 17:18:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:18:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:18:01 INFO - Running setup.py install for requests 17:18:01 INFO - Running setup.py install for docopt 17:18:01 INFO - Successfully installed blobuploader requests docopt 17:18:01 INFO - Cleaning up... 17:18:02 INFO - Return code: 0 17:18:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:18:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:18:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:18:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:02 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 0x7f374884ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b1a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba9790>, '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 0x2baa690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2baab20>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1473812252.13557-2082194890', '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 17:18:02 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 17:18:02 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 17:18:02 INFO - Using env: {'DISPLAY': ':0', 17:18:02 INFO - 'HOME': '/home/cltbld', 17:18:02 INFO - 'LANG': 'en_US.UTF-8', 17:18:02 INFO - 'LANGUAGE': 'en_US:en', 17:18:02 INFO - 'LOGNAME': 'cltbld', 17:18:02 INFO - 'MAIL': '/var/mail/cltbld', 17:18:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:02 INFO - 'MOZ_NO_REMOTE': '1', 17:18:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:02 INFO - 'NO_EM_RESTART': '1', 17:18:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:02 INFO - 'PWD': '/builds/slave/test', 17:18:02 INFO - 'SHELL': '/bin/bash', 17:18:02 INFO - 'SHLVL': '1', 17:18:02 INFO - 'TERM': 'linux', 17:18:02 INFO - 'TMOUT': '86400', 17:18:02 INFO - 'USER': 'cltbld', 17:18:02 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1473812252.13557-2082194890', 17:18:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:02 INFO - '_': '/tools/buildbot/bin/python'} 17:18:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:18:02 INFO - Running setup.py (path:/tmp/pip-3txHAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:18:02 INFO - Running setup.py (path:/tmp/pip-S3_Wew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:18:02 INFO - Running setup.py (path:/tmp/pip-Yrb6DM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:18:02 INFO - Running setup.py (path:/tmp/pip-BD_HlW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:18:02 INFO - Running setup.py (path:/tmp/pip-_k0_6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:18:02 INFO - Running setup.py (path:/tmp/pip-yZiv6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:18:02 INFO - Running setup.py (path:/tmp/pip-GNVs0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:18:02 INFO - Running setup.py (path:/tmp/pip-k4_5ER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:18:02 INFO - Running setup.py (path:/tmp/pip-cfhTgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:18:02 INFO - Running setup.py (path:/tmp/pip-6ZUHrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:18:02 INFO - Running setup.py (path:/tmp/pip-zIB_4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:18:03 INFO - Running setup.py (path:/tmp/pip-YyVzns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:18:03 INFO - Running setup.py (path:/tmp/pip-s9RVTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:18:03 INFO - Running setup.py (path:/tmp/pip-wWs6TE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:18:03 INFO - Running setup.py (path:/tmp/pip-OgxXUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:18:03 INFO - Running setup.py (path:/tmp/pip-9WA5HQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:18:03 INFO - Running setup.py (path:/tmp/pip-IIFbyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:18:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:18:03 INFO - Running setup.py install for manifestparser 17:18:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:18:03 INFO - Running setup.py install for mozcrash 17:18:03 INFO - Running setup.py install for mozdebug 17:18:03 INFO - Running setup.py install for mozdevice 17:18:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:18:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:18:03 INFO - Running setup.py install for mozfile 17:18:04 INFO - Running setup.py install for mozhttpd 17:18:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:18:04 INFO - Running setup.py install for mozinfo 17:18:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:18:04 INFO - Running setup.py install for mozInstall 17:18:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:18:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:18:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:18:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:18:04 INFO - Running setup.py install for mozleak 17:18:04 INFO - Running setup.py install for mozlog 17:18:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:18:04 INFO - Running setup.py install for moznetwork 17:18:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:18:04 INFO - Running setup.py install for mozprocess 17:18:04 INFO - Running setup.py install for mozprofile 17:18:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:18:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:18:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:18:04 INFO - Running setup.py install for mozrunner 17:18:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:18:04 INFO - Running setup.py install for mozscreenshot 17:18:05 INFO - Running setup.py install for moztest 17:18:05 INFO - Running setup.py install for mozversion 17:18:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:18:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:18:05 INFO - Cleaning up... 17:18:05 INFO - Return code: 0 17:18:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:18:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:18:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:05 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 0x7f374884ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b1a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba9790>, '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 0x2baa690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2baab20>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1473812252.13557-2082194890', '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 17:18:05 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 17:18:05 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 17:18:05 INFO - Using env: {'DISPLAY': ':0', 17:18:05 INFO - 'HOME': '/home/cltbld', 17:18:05 INFO - 'LANG': 'en_US.UTF-8', 17:18:05 INFO - 'LANGUAGE': 'en_US:en', 17:18:05 INFO - 'LOGNAME': 'cltbld', 17:18:05 INFO - 'MAIL': '/var/mail/cltbld', 17:18:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:05 INFO - 'MOZ_NO_REMOTE': '1', 17:18:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:05 INFO - 'NO_EM_RESTART': '1', 17:18:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:05 INFO - 'PWD': '/builds/slave/test', 17:18:05 INFO - 'SHELL': '/bin/bash', 17:18:05 INFO - 'SHLVL': '1', 17:18:05 INFO - 'TERM': 'linux', 17:18:05 INFO - 'TMOUT': '86400', 17:18:05 INFO - 'USER': 'cltbld', 17:18:05 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1473812252.13557-2082194890', 17:18:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:05 INFO - '_': '/tools/buildbot/bin/python'} 17:18:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:18:05 INFO - Running setup.py (path:/tmp/pip-D_xt3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:18:05 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)) 17:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:18:05 INFO - Running setup.py (path:/tmp/pip-Q6uFa7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:18:05 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)) 17:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:18:05 INFO - Running setup.py (path:/tmp/pip-LfZMyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:18:05 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)) 17:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:18:05 INFO - Running setup.py (path:/tmp/pip-zJLRgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:18:05 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)) 17:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:18:05 INFO - Running setup.py (path:/tmp/pip-03cD7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:18:05 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)) 17:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:18:05 INFO - Running setup.py (path:/tmp/pip-TuGwwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:18:05 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)) 17:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:18:05 INFO - Running setup.py (path:/tmp/pip-Dhernk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:18:06 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)) 17:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:18:06 INFO - Running setup.py (path:/tmp/pip-aO9hGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:18:06 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)) 17:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:18:06 INFO - Running setup.py (path:/tmp/pip-IWdttJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:18:06 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)) 17:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:18:06 INFO - Running setup.py (path:/tmp/pip-yhZdci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:18:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:18:06 INFO - Running setup.py (path:/tmp/pip-FdPhRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:18:06 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)) 17:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:18:06 INFO - Running setup.py (path:/tmp/pip-gntgcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:18:06 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)) 17:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:18:06 INFO - Running setup.py (path:/tmp/pip-9NDARa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:18:06 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)) 17:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:18:06 INFO - Running setup.py (path:/tmp/pip-xwzEu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:18:06 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)) 17:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:18:06 INFO - Running setup.py (path:/tmp/pip-uXtqmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:18:06 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)) 17:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:18:06 INFO - Running setup.py (path:/tmp/pip-RqvPsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:18:06 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)) 17:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:18:06 INFO - Running setup.py (path:/tmp/pip-B5Okih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:18:06 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)) 17:18:06 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)) 17:18:06 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)) 17:18:06 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)) 17:18:06 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)) 17:18:06 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)) 17:18:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:08 INFO - Downloading blessings-1.6.tar.gz 17:18:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:18:08 INFO - Installing collected packages: blessings 17:18:08 INFO - Running setup.py install for blessings 17:18:08 INFO - Successfully installed blessings 17:18:08 INFO - Cleaning up... 17:18:08 INFO - Return code: 0 17:18:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:18:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:18:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:18:09 INFO - Reading from file tmpfile_stdout 17:18:09 INFO - Current package versions: 17:18:09 INFO - argparse == 1.2.1 17:18:09 INFO - blessings == 1.6 17:18:09 INFO - blobuploader == 1.2.4 17:18:09 INFO - docopt == 0.6.1 17:18:09 INFO - functools32 == 3.2.3-2 17:18:09 INFO - jsonschema == 2.5.1 17:18:09 INFO - manifestparser == 1.1 17:18:09 INFO - mozInstall == 1.12 17:18:09 INFO - mozcrash == 0.17 17:18:09 INFO - mozdebug == 0.1 17:18:09 INFO - mozdevice == 0.48 17:18:09 INFO - mozfile == 1.2 17:18:09 INFO - mozhttpd == 0.7 17:18:09 INFO - mozinfo == 0.9 17:18:09 INFO - mozleak == 0.1 17:18:09 INFO - mozlog == 3.3 17:18:09 INFO - moznetwork == 0.27 17:18:09 INFO - mozprocess == 0.23 17:18:09 INFO - mozprofile == 0.28 17:18:09 INFO - mozrunner == 6.12 17:18:09 INFO - mozscreenshot == 0.1 17:18:09 INFO - mozsystemmonitor == 0.3 17:18:09 INFO - moztest == 0.7 17:18:09 INFO - mozversion == 1.4 17:18:09 INFO - psutil == 3.1.1 17:18:09 INFO - requests == 1.2.3 17:18:09 INFO - wsgiref == 0.1.2 17:18:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:18:09 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')]} 17:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:09 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')]} 17:18:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:09 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 0x7f374884ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b1a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba9790>, '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 0x2baa690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2baab20>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1473812252.13557-2082194890', '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 17:18:09 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 17:18:09 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 17:18:09 INFO - Using env: {'DISPLAY': ':0', 17:18:09 INFO - 'HOME': '/home/cltbld', 17:18:09 INFO - 'LANG': 'en_US.UTF-8', 17:18:09 INFO - 'LANGUAGE': 'en_US:en', 17:18:09 INFO - 'LOGNAME': 'cltbld', 17:18:09 INFO - 'MAIL': '/var/mail/cltbld', 17:18:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:09 INFO - 'MOZ_NO_REMOTE': '1', 17:18:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:09 INFO - 'NO_EM_RESTART': '1', 17:18:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:09 INFO - 'PWD': '/builds/slave/test', 17:18:09 INFO - 'SHELL': '/bin/bash', 17:18:09 INFO - 'SHLVL': '1', 17:18:09 INFO - 'TERM': 'linux', 17:18:09 INFO - 'TMOUT': '86400', 17:18:09 INFO - 'USER': 'cltbld', 17:18:09 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1473812252.13557-2082194890', 17:18:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:09 INFO - '_': '/tools/buildbot/bin/python'} 17:18:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:09 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)) 17:18:09 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)) 17:18:09 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)) 17:18:09 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)) 17:18:09 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)) 17:18:09 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)) 17:18:09 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)) 17:18:09 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)) 17:18:09 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)) 17:18:09 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)) 17:18:09 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)) 17:18:09 INFO - Cleaning up... 17:18:09 INFO - Return code: 0 17:18:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:18:09 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')]} 17:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:09 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')]} 17:18:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:09 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 0x7f374884ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b1a7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba9790>, '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 0x2baa690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2baab20>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1473812252.13557-2082194890', '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 17:18:09 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 17:18:09 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 17:18:09 INFO - Using env: {'DISPLAY': ':0', 17:18:09 INFO - 'HOME': '/home/cltbld', 17:18:09 INFO - 'LANG': 'en_US.UTF-8', 17:18:09 INFO - 'LANGUAGE': 'en_US:en', 17:18:09 INFO - 'LOGNAME': 'cltbld', 17:18:09 INFO - 'MAIL': '/var/mail/cltbld', 17:18:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:09 INFO - 'MOZ_NO_REMOTE': '1', 17:18:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:09 INFO - 'NO_EM_RESTART': '1', 17:18:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:09 INFO - 'PWD': '/builds/slave/test', 17:18:09 INFO - 'SHELL': '/bin/bash', 17:18:09 INFO - 'SHLVL': '1', 17:18:09 INFO - 'TERM': 'linux', 17:18:09 INFO - 'TMOUT': '86400', 17:18:09 INFO - 'USER': 'cltbld', 17:18:09 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1473812252.13557-2082194890', 17:18:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:09 INFO - '_': '/tools/buildbot/bin/python'} 17:18:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:18:09 INFO - Cleaning up... 17:18:09 INFO - Return code: 0 17:18:09 INFO - Running post-action listener: _resource_record_post_action 17:18:09 INFO - Running post-action listener: _start_resource_monitoring 17:18:09 INFO - Starting resource monitoring. 17:18:09 INFO - [mozharness: 2016-09-14 00:18:09.542285Z] Finished create-virtualenv step (success) 17:18:09 INFO - [mozharness: 2016-09-14 00:18:09.542822Z] Running install step. 17:18:09 INFO - Running pre-action listener: _resource_record_pre_action 17:18:09 INFO - Running main action method: install 17:18:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:18:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:18:09 INFO - Reading from file tmpfile_stdout 17:18:09 INFO - Detecting whether we're running mozinstall >=1.0... 17:18:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:18:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:18:09 INFO - Reading from file tmpfile_stdout 17:18:09 INFO - Output received: 17:18:09 INFO - Usage: mozinstall [options] installer 17:18:09 INFO - Options: 17:18:09 INFO - -h, --help show this help message and exit 17:18:09 INFO - -d DEST, --destination=DEST 17:18:09 INFO - Directory to install application into. [default: 17:18:09 INFO - "/builds/slave/test"] 17:18:09 INFO - --app=APP Application being installed. [default: firefox] 17:18:09 INFO - mkdir: /builds/slave/test/build/application 17:18:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:18:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:18:26 INFO - Reading from file tmpfile_stdout 17:18:26 INFO - Output received: 17:18:26 INFO - /builds/slave/test/build/application/firefox/firefox 17:18:26 INFO - Running post-action listener: _resource_record_post_action 17:18:26 INFO - [mozharness: 2016-09-14 00:18:26.792852Z] Finished install step (success) 17:18:26 INFO - [mozharness: 2016-09-14 00:18:26.793096Z] Running run-tests step. 17:18:26 INFO - Running pre-action listener: _resource_record_pre_action 17:18:26 INFO - Running main action method: run_tests 17:18:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:18:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:18:26 INFO - Python 2.7.3 17:18:26 INFO - Return code: 0 17:18:26 INFO - grabbing minidump binary from tooltool 17:18:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:18:26 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 0x2ba9790>, '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 0x2baa690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2baab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:18:26 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 17:18:26 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 17:18:26 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 17:18:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:18:26 INFO - Return code: 0 17:18:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:18:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:18:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:18:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:18:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:18:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JuthdzfDSpSbZctGsn6BlA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 17:18:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JuthdzfDSpSbZctGsn6BlA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 17:18:26 INFO - Using env: {'DISPLAY': ':0', 17:18:26 INFO - 'HOME': '/home/cltbld', 17:18:26 INFO - 'LANG': 'en_US.UTF-8', 17:18:26 INFO - 'LANGUAGE': 'en_US:en', 17:18:26 INFO - 'LOGNAME': 'cltbld', 17:18:26 INFO - 'MAIL': '/var/mail/cltbld', 17:18:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:18:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:18:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:26 INFO - 'MOZ_NO_REMOTE': '1', 17:18:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:18:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:26 INFO - 'NO_EM_RESTART': '1', 17:18:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:26 INFO - 'PWD': '/builds/slave/test', 17:18:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:18:26 INFO - 'SHELL': '/bin/bash', 17:18:26 INFO - 'SHLVL': '1', 17:18:26 INFO - 'TERM': 'linux', 17:18:26 INFO - 'TMOUT': '86400', 17:18:26 INFO - 'USER': 'cltbld', 17:18:26 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1473812252.13557-2082194890', 17:18:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:26 INFO - '_': '/tools/buildbot/bin/python'} 17:18:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JuthdzfDSpSbZctGsn6BlA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:18:27 INFO - mozversion application_buildid: 20160913153006 17:18:27 INFO - mozversion application_changeset: cec9f17302dbc776fa3a43c3a3c81e7fee873f0f 17:18:27 INFO - mozversion application_display_name: Nightly 17:18:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:18:27 INFO - mozversion application_name: Firefox 17:18:27 INFO - mozversion application_remotingname: firefox 17:18:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 17:18:27 INFO - mozversion application_vendor: Mozilla 17:18:27 INFO - mozversion application_version: 51.0a1 17:18:27 INFO - mozversion platform_buildid: 20160913153006 17:18:27 INFO - mozversion platform_changeset: cec9f17302dbc776fa3a43c3a3c81e7fee873f0f 17:18:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 17:18:27 INFO - mozversion platform_version: 51.0a1 17:18:27 INFO - using testdate: 1473812307 17:18:27 INFO - actual date: 1473812307 17:18:27 INFO - starting webserver on 'localhost:48700' 17:18:27 INFO - SUITE-START | Running 2 tests 17:18:27 INFO - TEST-START | dromaeo_css 17:18:27 INFO - operating with platform_type : linux_ 17:18:27 INFO - Initialising browser for dromaeo_css test... 17:18:27 INFO - TEST-INFO | started process 13307 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkZVtYZ/profile http://localhost:48700/getInfo.html) 17:18:31 INFO - PROCESS | 13307 | __metrics Screen width/height:1600/1200 17:18:31 INFO - PROCESS | 13307 | colorDepth:24 17:18:31 INFO - PROCESS | 13307 | Browser inner width/height: 1024/697 17:18:31 INFO - PROCESS | 13307 | __metrics 17:18:32 INFO - PROCESS | 13307 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:18:32 INFO - PROCESS | 13307 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:18:32 INFO - PROCESS | 13307 | console.error: PushService: 17:18:32 INFO - PROCESS | 13307 | stateChangeProcessEnqueue: Error transitioning state 17:18:32 INFO - PROCESS | 13307 | UnknownError 17:18:33 INFO - TEST-INFO | 13307: exit 0 17:18:33 INFO - Browser initialized. 17:18:33 INFO - Running cycle 1/1 for dromaeo_css test... 17:18:33 INFO - TEST-INFO | started process 13389 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkZVtYZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:18:45 INFO - PROCESS | 13389 | RSS: Main: 174247936 17:18:45 INFO - PROCESS | 13389 | 17:19:36 INFO - PROCESS | 13389 | 1473812376841 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:21:46 INFO - PROCESS | 13389 | Cycle 1(1): loaded http://localhost:48700/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48700/tests/dromaeo/cssquery-ext.html) 17:21:47 INFO - PROCESS | 13389 | RSS: Main: 318545920 17:21:47 INFO - PROCESS | 13389 | 17:24:50 INFO - PROCESS | 13389 | Cycle 1(1): loaded http://localhost:48700/tests/dromaeo/cssquery-ext.html (next: http://localhost:48700/tests/dromaeo/cssquery-jquery.html) 17:24:50 INFO - PROCESS | 13389 | RSS: Main: 273694720 17:24:50 INFO - PROCESS | 13389 | 17:27:52 INFO - PROCESS | 13389 | Cycle 1(1): loaded http://localhost:48700/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48700/tests/dromaeo/cssquery-mootools.html) 17:27:53 INFO - PROCESS | 13389 | RSS: Main: 213942272 17:27:53 INFO - PROCESS | 13389 | 17:30:55 INFO - PROCESS | 13389 | Cycle 1(1): loaded http://localhost:48700/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48700/tests/dromaeo/cssquery-prototype.html) 17:30:55 INFO - PROCESS | 13389 | RSS: Main: 268636160 17:30:55 INFO - PROCESS | 13389 | 17:33:58 INFO - PROCESS | 13389 | Cycle 1(1): loaded http://localhost:48700/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48700/tests/dromaeo/cssquery-yui.html) 17:33:59 INFO - PROCESS | 13389 | RSS: Main: 216207360 17:33:59 INFO - PROCESS | 13389 | 17:37:02 INFO - PROCESS | 13389 | Cycle 1(1): loaded http://localhost:48700/tests/dromaeo/cssquery-yui.html (next: http://localhost:48700/tests/dromaeo/cssquery-dojo.html) 17:37:02 INFO - PROCESS | 13389 | RSS: Main: 309592064 17:37:02 INFO - PROCESS | 13389 | 17:37:02 INFO - PROCESS | 13389 | __start_tp_report 17:37:02 INFO - PROCESS | 13389 | _x_x_mozilla_page_load 17:37:02 INFO - PROCESS | 13389 | _x_x_mozilla_page_load_details 17:37:02 INFO - PROCESS | 13389 | |i|pagename|runs| 17:37:02 INFO - PROCESS | 13389 | |0;dojo.html;2955.4236923799854;3002.924926876827;3009.804362716422;3043.6499802522717;3058.9293747188485;5228.189630607252;5295.4704529547025;5305.787768489261;5413.702246376452;5431.239626452295;5299.761510732017;5322.281491998579;5360.785568577252;5387.488188622085;5443.2107344435035;4756.500567440421;4802.015586804697;4806.735629540374;4825.710457372551;4835.613150947934;4923.286123512089;4957.5786058185095;4958.851234462972;4959.727215003173;4993.101241776479;4662.114198302312;4695.718256904596;4707.129181101507;4818.807247710088;4829.1307564638355;4732.02993386355;4785.353977213066;4796.544328288807;4872.025594881003;4888.826681596427;4736.810527578893;4775.116603428377;4775.785089670973;4849.709017458964;4852.878678033042;5302.151655735102;5321.042212401766;5321.494458026481;5324.068288049576;5330.840074797762;5529.170624406331;5583.8604034899045;5650.434956504317;5651.717414129318;5709.74306156224;5720.8283751487525;5744.942550574524;5746.511546518551;5801;5805.709714514257;5347.358317001946;5352.785888564453;5358.169483730028;5368.382635996872;5368.516833485005;5523.502884740393;5631.802886898939;5815.069588865761;5841.795537156264;5863.120531920246;5604.887902241932;5637;5659.660420374791;5719.571032172604;5726.856828579319;5713.314402271754;5758.769649213985;5764.365919748824;5767.279090113736;5768.567357448208;5476.424975377608;5534.972325138429;5705.058665320259;5712.857178570569;5718.542516598662;5667.291588551431;5675.432456754292;5739.339975902824;5739.885202295931;5741.827745167651;4371.125774845043;4383.60547550722;4386.232409328419;4431.645468362523;4439.178751930903;3875.2636998970106;3879.7478163919254;3899.3760998240145;3919.3141200289833;3929.3713005918917;5267.657602255841;5317.973410133002;5348.197770334481;5349.759260833272;5455.372632147354;5690.715464226855;5702.54379649627;5703.7148142592705;5704.743286552115;5705.115707065412;5334.839954801362;5380.192971054373;5382.596305277041;5388.299521062237;5450.264214331015;4855.223164293696;4856.95143048565;4899.681520701143;4900.117978763786;4914.164592019365;5743.9425605744245;5757.6833274169485;5759.596828222068;5760.135979603093;5819.388964158702;5664.603477756682;5673.092305231144;5678.630888992202;5683.204351390726;5688.345840228261;5497.697626630574;5505.366882808368;5663.263775709132;5663.575231857545;5757.740901659352;5516.779328826802;5522.337319521523;5534.86162845916;5598.468145526169;5607.046802043581;5569.443055694398;5586.553075753849;5598.048331783525;5601.187827765033;5602.607817452902;5424.267723857387;5445.074337362737;5457.263269458573;5517.117261238343;5526.751296191601;5446.373667028184;5473.288472498709;5474.479924407175;5522.22688823573;5541.972290138524;5417.620766546304;5418.485243901823;5418.674879507243;5421.457854214547;5423.945760542502;5388.515033646991;5518.034343989705;5536.370169275082;5548.889022219452;5554.833354999357;5360.544353729977;5387.218853266333;5427.810026649048;5438.782448702008;5440.183972404171 17:37:02 INFO - PROCESS | 13389 | |1;ext.html;551.4715031580205;595.8182754259951;598.0640297933734;610.1762620462374;614.0237023133219;33417;44467.555324446745;45524.544754552444;45600.543994560045;45646.77176614112;47022;47428.76285618576;47507;47578.28632570514;47614.761926190404;9049.864252036225;9109.681161159328;9113;9122.498262595554;9219.861702074475;9018.59416326267;9080.500572468512;9092.090790920922;9116.954415227949;9122.954385228064;9094.36339456235;9165.58754856033;9170.082991700843;9170.312226582999;9177.265818734486;9094.54527273637;9131.497767622777;9132.634694612207;9137.269018478506;9155.267578593763;8992.730218093468;9027.954860225656;9028.41315314509;9042.547872606343;9050.864237036383;42529.36205956913;42944;42968;42969.78515107436;42979.57020429787;3654.6162652921325;3655.141041855162;3678.4666223397458;3752.587215406303;3871.5741268460447;31900;31979.680203197902;31998.680013199802;32082.839585802154;32474.675253247402;4144.8134833932545;4301.501364651799;4305.526392096866;4327.567243275679;4399.802008909607;343603;345482;346613;348748;348844;58308;58740.412595874346;58756.41243587595;58837.41162588405;58868.41131588715;53455.46544534505;54089.94325425609;60017.99640072003;60030.39969600248;60263;15581.610459738371;16463.91768041152;16629.251683674265;16647.583810404838;16655.83344166567;12837;12966.481340746453;12967;12973.805392919114;12989.610311690665;15174.317155728018;15317.23413829304;16437.83562164363;16833.242504087346;16850.32598696063;5748.913766293509;5852.385499522574;5855.066385048283;5914.378990206053;6106.572539922163;876.1763941894599;959.822432849925;987.1855719031828;1057.5188289328337;1084.951177197028;33002;33099.83450082734;33128.50307245393;33181.50227746586;33554;1083.3987137138806;1092.3445932440632;1141.9086473082134;1150.6030419505257;1177.7291223018753;16267.349306027627;16947;17064.146792660318;17066.829331706525;17200.655986880192;530776;533543.9747230357;533876;534416;535135;58367.24898253059;58981;58988.11517827236;58999;59037;1307.1438207973792;1307.6469353274563;1350.554317075343;1358.5041459867077;1361.5438827992534;30164;31368;32060.358792824478;32389.838050809594;32609.836950815094;51721.7413912928;52093;52158;52221;52249;356208;357012;358362;359181;359291;36450.27099458049;37212.73025152746;37911.62088379081;41897;42175.36736949009;40288;40412.79793601013;47150.76424617855;47408.525914740414;47562.76218618885;40336;41073.794631026656;41897.58102418937;42064.78967605143;42985;41229.96925076897;41539.58460415478;41566.16867662569;42615.7869210652;42818;40110;40559.986000350225;41203.7939810299;41307;44563.33155002613;33983.83008085043;36792;37469;37636.24727505489;38232.235355292185;27814.44371112607;28092.578611321256;28321.858390708738;28439.573406398507;28559 17:37:02 INFO - PROCESS | 13389 | |2;jquery.html;376.6177330010042;398.1360447828213;403.95556488786235;407.1429640606522;414.05182132915627;13627.182369057851;14852.554423367303;18995;19536.413907582795;19994.900025499854;19183.23267069319;19355.709664355047;19736.111874965623;19779.505512362197;19796.70304945427;5380.650257733254;5679.148127780824;5933.110033494967;5934.109883517485;5935.347111817697;6483.773067942623;6690.464762818987;6690.83272918176;6711.6979735912;6720.227173875018;6468.353164683517;6544.851158539017;6604.2405123410945;6659.93340066598;6672.733090676367;6370.840728981766;6548.214214294291;6586.637734924578;6588.439982601484;6588.571742836724;5795.275590551181;5831.708414579254;5835.824925252206;5836.737346819404;5838.474537291664;22849;23414.76585234143;23426.648600271008;23615.409614759596;23684.28947131589;2329.2895666821614;2370.0401337458356;2389.0443822470975;2427.5630386530415;2544.821862469628;13649.454021839114;14677.706445871023;14990.100593964396;15405.22973851303;15440.45958391451;1803.9729404058949;1864.813518648138;1885.283592234942;1931.9323823666105;1962.5093726568357;53918.73040634772;73988.63005684938;77581.61209193974;78128.60935695341;86639.99999999937;10508.684739457829;10626.681199564026;10814.837777433344;10899.1280697544;11191.496382662799;15237.238138093051;15301.693966120616;15302.387904483696;15321.46374876874;15342.76985845191;7808.141104478503;8181.668224556092;8192.221738934792;8382.790430239293;8436.578171091543;7923.960380198062;7954.164812694699;7977.242161994601;8191.631376588068;8195.180481951757;6626.801195964129;6713.597184168965;6729.22613899398;6766.357196066366;6934.47991400647;1839.8160183981763;1912.9713054304198;1919.280269898788;1925.3261358524405;1973.1219607274911;885.5970533407284;928.7910220200536;1009.5557954500143;1011.9691523886008;1091.5682329741117;19771;19791.703124453146;20470.283540076027;20477.18091276362;20525.38423847287;968.2737946540095;980.3921568627496;995.2734503812258;1004.5128112865254;1071.989280107189;10999.945000275107;11481.253718508271;11494.94252528732;11498.827517587242;11500.654980350602;459209;469048;473126;474126;475029;79859.60070199613;79973;80016;80450.59774701206;80973;1018.8013337399136;1062.4103622489438;1064.180580952662;1073.5705717712822;1078.191356482638;17282.481525554253;17522.73715894237;18034.909825450788;18049;18278.17748201361;39851.80074099611;41012.15445304909;41713.79143104265;42104.57895421129;42796.38357314578;53116.46883531115;53897.730511347196;55013;55577.72211138919;58618.12072818826;8412.747617571482;8634.654613815377;8638.870416943877;8804;8846.955765221133;9926.908040115726;12132.454039568418;13265;13421.530246441718;13957.441702331793;11150.721231969266;11253.943730281297;11386.43067846621;11686.94156529212;11947.641570752892;11196.888031119584;11422.31466112036;11650.592229271935;12082.818757718465;12111;11681.299122052704;12064.51741930348;12144.089193310714;12179.87820121823;12275.140740148105;7869.48848324857;8675.30597552207;8699.695510657097;8830.42602230853;8892.822143557221;11295.096392288762;11440.542378304775;11638.70903227426;11718.23831450953;11984.880151198377 17:37:02 INFO - PROCESS | 13389 | |3;mootools.html;1345.192884269439;1487.6429656882349;1500.7973923520326;1655.7185278502654;1790.489710432527;7747.845043099134;8489.872651910226;8849.424787388814;8873.866891996626;8892.955535222314;8813.735587932357;8985.91014089859;8986.2810975122;8995.640174393033;9000.504972226541;2323.74438811731;2364.858108513486;2367.562001029806;2372.418757404438;2373.1456675596773;2243.8653680779207;2280.600894843404;2338.368640467073;2341.637046257833;2343.8593684378993;2392.1149174805346;2400.5558971590312;2418.8669623170717;2418.8790560471994;2425.527022230666;2279.09975559653;2298.276043046443;2299.6895419118373;2301.1255722825385;2339.9649005264764;2272.1025195047864;2275.306031660343;2277.760835112306;2280.2589158523547;2285.6914316567218;8743.693970711058;8963.596638151299;8966.193042626195;9026.638934442615;9037.367384283103;5146.459621739701;5380.2736630555155;5387.299651045339;5389.78440862365;5393.73031348435;3277.8197199154038;3284.8521816518314;3345.2305969627123;3355.312161006988;3361.6806403391884;1085.365061439059;1089.4661615808277;1105.9533019897237;1118.7650593375402;1125.5104029747085;12610.180338277982;12802.42389092493;12859.549915752903;12884.742305153844;12894.419751111316;4753.2684948979395;4779.880502987384;4783.832565860178;4890.535399137077;4933.580645645088;10915.727106822393;10926.890731092588;10935.507902144423;10938.234323597431;10948.178886583539;5411.053065713484;5438.945610543923;5441.183822426588;5447.972760136253;5448.891022179613;4295.076558539929;4406.889827754332;4780.737059461763;4904.190808516626;4995.050940321327;3940.113474468279;4009.51885773709;4036.1120553478186;4094.181163767199;4111.033907031845;1304.784710522772;1307.5815738963631;1308.4046758724758;1331.9134256273505;1359.7552440560596;885.4112015509743;912.4069354919355;913.8903331600118;919.8068405634758;936.9437833729997;5677.545796336283;5705.71471426427;5805.88388232233;5870.618409803349;6106.419890110433;464.8512476007713;469.10167030137586;473.7134033909504;492.3746841511261;492.56900212314224;3775.1505911169766;3927.3127202739406;3927.351986922183;3936.1340505088833;4002.2795896738285;11170.720731981766;11480.770384592428;11607.245529040585;11634.301941883514;11637.359945202927;11199.21605487608;11397;11424.42877856104;11429.771404571862;11505.137114716263;8248.422610417214;8268.751937441766;8415.200555947175;8450;8492.490450572985;5942.465178133989;5952.375000624872;6000.189974353581;6041.577089603686;6177.84555386119;10160.390376577428;10488.842667359842;10508.054275115277;10559.736006599896;10577.9471102644;10078.748031299276;10473.842892356468;10481.161507079567;10668.573257069631;10786.298890572089;7066.929330706627;7131.8930216045765;7188.317109874553;8129.309008734087;8274.420790544846;7852.84294314122;7926.48477848938;8157.8368432632205;8339.916600834156;8440.95779521123;7870.527768333918;7933.087694915159;8003.119656837627;8146.185381461806;8255.050669173123;7760.146383897654;7871.173526779835;7886;7898.131205567268;7899.249571290718;6924.6537673117155;7030.929690703232;7034.683439245144;7037.577745335297;7040.331168538981;4899.387576552931;4937.456879743298;4970.8757281068265;4980.726060066586;5025.74871256443;5316.415194328543;5316.415194328698;5334.146536554133;5440.292761940922;5536.750846211849 17:37:02 INFO - PROCESS | 13389 | |4;prototype.html;318.837392929606;333.92143376892636;339.3315169116839;340.3227577121529;343.36991620376614;5179.559737422323;5231.529162375386;5283.709395983219;5289.889123284105;5340.424574750448;5206.609504287175;5235.921461178085;5246.160614301703;5246.481688789383;5259.342582177228;4114.855980040699;4117.991092182419;4124.237016152014;4124.8143833527565;4139.254934111858;3988.9601103989025;4060.822361515172;4084.836606535735;4113.403556484308;4135.627793498585;4021.396790481422;4048.3725022621393;4051.7163798534116;4057.3305404608204;4101.405296232045;4096.344584866422;4106.096658735073;4109.157622687342;4111.938320925188;4150.211459822624;3660.7071434285194;3662.706983441345;3687.723420743428;3690.5940346561856;3692.095436618046;4900.215965445547;5128.333316668846;5139.254808052849;5142.1772516397195;5187.247849061865;4658.813647454098;4681.836135735267;4716.52834716529;4717.315989181549;4724.149653062447;5230.293910322096;5405.675659460445;5466.398696143461;5475.616706830523;5487.722595123019;3890.922181556353;3900.3369427197445;3934.8229329680235;3945.3884647879627;3961.187956468917;5375.489328513785;5601.747921343549;5689.236336735626;5729.484346408802;5739.885202295973;3892.8053597320586;3926.8821935341984;3929.626685464876;3931.9973406781087;3962.2669806085964;4115.670746340285;4130.752154870717;4133.132042271157;4136.44158038667;4143.647789937889;4568.337591049346;4650.581447669659;4729.2906064089975;4737.620990320766;4754.144254034307;5524.364698059694;5534.335879694462;5538.224648549206;5542.501174894279;5575;1394.5607133753037;1419.5031738891512;1420.94849811139;1427.3862239237021;1428.4643258777958;856.1609622569792;925.167349385545;925.6898938855559;936.3773090894615;939.5114540438933;4677.462091859412;4731.574158325767;4754.78603462845;4782.497837727058;4788.688735232199;4959.7272150032095;4971.676841005323;4977.751112444364;5003.424606170264;5009.847735020966;4700.226866148989;4728.905421891612;4737.38414006177;4754.310624959361;4835.178019736653;2897.8985735499155;2948.569943577363;2965.1845742421006;2969.940601187964;2973.182374846934;5673.290838645169;5693.259876216065;5694.174344719992;5699.070304186848;5741.62679425836;5631.211630371751;5723.198752174699;5748.425157484302;5748.683822389725;5823.30120385548;5636.887262254732;5646.491815736604;5683.2895888014;5686.289213848269;5689.065717656017;5367.221752845738;5594.356648985418;5611.3266408031295;5634.6337488063145;5658.85852853682;5554.555635549227;5563.916541251965;5568.443155684561;5589.720513974366;5612.971935140298;5419.187121931742;5538.556915446674;5589;5725.742341594721;5758.884822303614;4046.4941882264716;4068.1253530491085;4068.7558746475306;4070.2266569351727;4071.857484988011;5660.15097735343;5665.178549110438;5674.2623458950075;5678.971605141948;5683.090705487102;5304.427352733998;5405.702686352289;5439.619226654097;5474.972625136849;5522.282103326703;5468.480494353189;5477.740119772395;5479.821838304783;5484.945150548443;5493.340799104133;5309.7345132743985;5476.726163691879;5500.339959204921;5516.724163791714;5524.790083966445;5402.891942161056;5512.724363781875;5559.2217089606675;5569.359523654832;5579.609427340048;5414.891702165856;5439.619226654097;5449.809256675997;5450;5454.045542030208 17:37:02 INFO - PROCESS | 13389 | |5;yui.html;730.4521608793408;787.7794217619065;793.8134538383481;803.2489622203238;836.6904245429184;16088.83911160888;16976.74534881978;16986.235619397125;16991.065491397967;17019.31922723091;15327.770083448757;15486.845131548682;15513.922430387833;15522.5343239703;15530.45643402481;643.6910283064132;659.2780904909141;761.6344154805697;770.1528318849277;791.5290402210676;773.4663082473104;780.4302858912997;781.6756046240831;784;789.4316092413482;820.0323618130603;820.7660816667251;822.2106777493583;822.3256929317962;822.4325215601245;672.1799404726202;686.0361192524512;809.8987626546682;819.1112642782558;819.7704642700023;611.626907586372;613.6164896939413;613.8772245550863;615.4522474997256;616.5930485879298;16019.839801601951;16130.919345403197;16132.193390330436;16146.192690365435;16164;14191.858081419157;14309.712125908718;14527.92736036313;14673.633159170999;14700.926495367561;13167.670808229776;13211.40548675312;13466.596002119952;13626.250556219404;13822.447102115902;4541.364209010741;4605.562471565196;4747.050589882003;4824.2040063389495;4851.9272210916515;81325.59337203336;82096.9999999994;84163;84314.57842710809;84978;10711.517981690842;10857.34855908648;11185.66443006711;11265.831012534654;11823.586174483851;22365.888170559043;22369.44076398103;22416;22423;22451.55096898053;8103.1491693371345;8369.246767790928;8563.100874408223;8647.264982476434;8810.559472026373;4451.132029254264;4660.673752837337;4672.719636821802;4687.1328804171335;4723.267893476448;3382.7801192922875;3468.4450487921813;3483.790972541605;3486.0413386318965;3494.4408894576745;556.9220309156722;563.023154826376;578.8147792706378;579.6232448908244;586.8298193523916;563.6871536297394;610.3255902227974;687.608063403855;698.2703075286338;701.551007355293;8655.17775811297;9252.814943701089;9323.906760932305;9342.719718408458;9511.57197926095;572.324656904848;659.8020593821834;678.1252184681804;701.9894701579481;713.5183750968076;4292;4440.777961101932;4447.421835161408;4450.599446049871;4462.352958820953;102182;104280.8125103011;107077;121225.48357905984;125902;97966;98876.50561747146;99324;99338.50330748444;100880;55196;61348.38651613516;86055.56972215224;86602;87704.56147719221;10070.8489372658;10274.640387586698;10495.279506805278;10636.627718029831;10681.57273709074;48104;48586;50749;51155;51182;65265;66025.66987165033;67149.66425167843;69128.6543567279;75068;13330.800037999245;13387.732245355233;13439.529616463376;13690.38393272325;14256.215908125152;15097.622559436102;15196;15429;16420.589485262964;16781.328746849988;13761.79357309621;13905.860941390456;14033.929830350782;14422.639434014234;15283.541493755205;13404.32978351098;13831;13909;13933.860661393663;14558.4904528341;13524.93237533806;13574.79637805414;13671.726565468436;14223.928880355532;15122.621934451727;10481.528331225265;10774.515146818256;11218.439078045902;11389;11631.360275184947;9418.95290523543;10247.641332553325;10433.113185379025;10550.630727924487;10604.469776511298 17:37:02 INFO - PROCESS | 13389 | __end_tp_report 17:37:02 INFO - PROCESS | 13389 | __start_cc_report 17:37:02 INFO - PROCESS | 13389 | _x_x_mozilla_cycle_collect,1106 17:37:02 INFO - PROCESS | 13389 | __end_cc_report 17:37:02 INFO - PROCESS | 13389 | __startTimestamp1473813422267__endTimestamp 17:37:02 INFO - PROCESS | 13389 | 17:37:02 INFO - PROCESS | 13389 | ------- Summary: start ------- 17:37:02 INFO - PROCESS | 13389 | Number of tests: 6 17:37:02 INFO - PROCESS | 13389 | 17:37:02 INFO - PROCESS | 13389 | [#0] dojo.html Cycles:165 Average:5258.84 Median:5438.78 stddev:589.88 (10.8%) stddev-sans-first:563.33 17:37:02 INFO - PROCESS | 13389 | Values: 2955.4 3002.9 3009.8 3043.6 3058.9 5228.2 5295.5 5305.8 5413.7 5431.2 5299.8 5322.3 5360.8 5387.5 5443.2 4756.5 4802.0 4806.7 4825.7 4835.6 4923.3 4957.6 4958.9 4959.7 4993.1 4662.1 4695.7 4707.1 4818.8 4829.1 4732.0 4785.4 4796.5 4872.0 4888.8 4736.8 4775.1 4775.8 4849.7 4852.9 5302.2 5321.0 5321.5 5324.1 5330.8 5529.2 5583.9 5650.4 5651.7 5709.7 5720.8 5744.9 5746.5 5801.0 5805.7 5347.4 5352.8 5358.2 5368.4 5368.5 5523.5 5631.8 5815.1 5841.8 5863.1 5604.9 5637.0 5659.7 5719.6 5726.9 5713.3 5758.8 5764.4 5767.3 5768.6 5476.4 5535.0 5705.1 5712.9 5718.5 5667.3 5675.4 5739.3 5739.9 5741.8 4371.1 4383.6 4386.2 4431.6 4439.2 3875.3 3879.7 3899.4 3919.3 3929.4 5267.7 5318.0 5348.2 5349.8 5455.4 5690.7 5702.5 5703.7 5704.7 5705.1 5334.8 5380.2 5382.6 5388.3 5450.3 4855.2 4857.0 4899.7 4900.1 4914.2 5743.9 5757.7 5759.6 5760.1 5819.4 5664.6 5673.1 5678.6 5683.2 5688.3 5497.7 5505.4 5663.3 5663.6 5757.7 5516.8 5522.3 5534.9 5598.5 5607.0 5569.4 5586.6 5598.0 5601.2 5602.6 5424.3 5445.1 5457.3 5517.1 5526.8 5446.4 5473.3 5474.5 5522.2 5542.0 5417.6 5418.5 5418.7 5421.5 5423.9 5388.5 5518.0 5536.4 5548.9 5554.8 5360.5 5387.2 5427.8 5438.8 5440.2 17:37:02 INFO - PROCESS | 13389 | 17:37:02 INFO - PROCESS | 13389 | [#1] ext.html Cycles:180 Average:58208.17 Median:42120.08 stddev:111550.76 (264.8%) stddev-sans-first:111779.69 17:37:02 INFO - PROCESS | 13389 | Values: 551.5 595.8 598.1 610.2 614.0 33417.0 44467.6 45524.5 45600.5 45646.8 47022.0 47428.8 47507.0 47578.3 47614.8 9049.9 9109.7 9113.0 9122.5 9219.9 9018.6 9080.5 9092.1 9117.0 9123.0 9094.4 9165.6 9170.1 9170.3 9177.3 9094.5 9131.5 9132.6 9137.3 9155.3 8992.7 9028.0 9028.4 9042.5 9050.9 42529.4 42944.0 42968.0 42969.8 42979.6 3654.6 3655.1 3678.5 3752.6 3871.6 31900.0 31979.7 31998.7 32082.8 32474.7 4144.8 4301.5 4305.5 4327.6 4399.8 343603.0 345482.0 346613.0 348748.0 348844.0 58308.0 58740.4 58756.4 58837.4 58868.4 53455.5 54089.9 60018.0 60030.4 60263.0 15581.6 16463.9 16629.3 16647.6 16655.8 12837.0 12966.5 12967.0 12973.8 12989.6 15174.3 15317.2 16437.8 16833.2 16850.3 5748.9 5852.4 5855.1 5914.4 6106.6 876.2 959.8 987.2 1057.5 1085.0 33002.0 33099.8 33128.5 33181.5 33554.0 1083.4 1092.3 1141.9 1150.6 1177.7 16267.3 16947.0 17064.1 17066.8 17200.7 530776.0 533544.0 533876.0 534416.0 535135.0 58367.2 58981.0 58988.1 58999.0 59037.0 1307.1 1307.6 1350.6 1358.5 1361.5 30164.0 31368.0 32060.4 32389.8 32609.8 51721.7 52093.0 52158.0 52221.0 52249.0 356208.0 357012.0 358362.0 359181.0 359291.0 36450.3 37212.7 37911.6 41897.0 42175.4 40288.0 40412.8 47150.8 47408.5 47562.8 40336.0 41073.8 41897.6 42064.8 42985.0 41230.0 41539.6 41566.2 42615.8 42818.0 40110.0 40560.0 41203.8 41307.0 44563.3 33983.8 36792.0 37469.0 37636.2 38232.2 27814.4 28092.6 28321.9 28439.6 28559.0 17:37:02 INFO - PROCESS | 13389 | 17:37:02 INFO - PROCESS | 13389 | [#2] jquery.html Cycles:180 Average:28128.30 Median:2379.54 stddev:77187.20 (3243.8%) stddev-sans-first:77375.61 17:37:02 INFO - PROCESS | 13389 | Values: 376.6 398.1 404.0 407.1 414.1 13627.2 14852.6 18995.0 19536.4 19994.9 19183.2 19355.7 19736.1 19779.5 19796.7 5380.7 5679.1 5933.1 5934.1 5935.3 6483.8 6690.5 6690.8 6711.7 6720.2 6468.4 6544.9 6604.2 6659.9 6672.7 6370.8 6548.2 6586.6 6588.4 6588.6 5795.3 5831.7 5835.8 5836.7 5838.5 22849.0 23414.8 23426.6 23615.4 23684.3 2329.3 2370.0 2389.0 2427.6 2544.8 13649.5 14677.7 14990.1 15405.2 15440.5 1804.0 1864.8 1885.3 1931.9 1962.5 53918.7 73988.6 77581.6 78128.6 86640.0 10508.7 10626.7 10814.8 10899.1 11191.5 15237.2 15301.7 15302.4 15321.5 15342.8 7808.1 8181.7 8192.2 8382.8 8436.6 7924.0 7954.2 7977.2 8191.6 8195.2 6626.8 6713.6 6729.2 6766.4 6934.5 1839.8 1913.0 1919.3 1925.3 1973.1 885.6 928.8 1009.6 1012.0 1091.6 19771.0 19791.7 20470.3 20477.2 20525.4 968.3 980.4 995.3 1004.5 1072.0 10999.9 11481.3 11494.9 11498.8 11500.7 459209.0 469048.0 473126.0 474126.0 475029.0 79859.6 79973.0 80016.0 80450.6 80973.0 1018.8 1062.4 1064.2 1073.6 1078.2 17282.5 17522.7 18034.9 18049.0 18278.2 39851.8 41012.2 41713.8 42104.6 42796.4 53116.5 53897.7 55013.0 55577.7 58618.1 8412.7 8634.7 8638.9 8804.0 8847.0 9926.9 12132.5 13265.0 13421.5 13957.4 11150.7 11253.9 11386.4 11686.9 11947.6 11196.9 11422.3 11650.6 12082.8 12111.0 11681.3 12064.5 12144.1 12179.9 12275.1 7869.5 8675.3 8699.7 8830.4 8892.8 11295.1 11440.5 11638.7 11718.2 11984.9 17:37:02 INFO - PROCESS | 13389 | 17:37:02 INFO - PROCESS | 13389 | [#3] mootools.html Cycles:180 Average:5885.33 Median:4766.57 stddev:3449.13 (72.4%) stddev-sans-first:3441.93 17:37:02 INFO - PROCESS | 13389 | Values: 1345.2 1487.6 1500.8 1655.7 1790.5 7747.8 8489.9 8849.4 8873.9 8893.0 8813.7 8985.9 8986.3 8995.6 9000.5 2323.7 2364.9 2367.6 2372.4 2373.1 2243.9 2280.6 2338.4 2341.6 2343.9 2392.1 2400.6 2418.9 2418.9 2425.5 2279.1 2298.3 2299.7 2301.1 2340.0 2272.1 2275.3 2277.8 2280.3 2285.7 8743.7 8963.6 8966.2 9026.6 9037.4 5146.5 5380.3 5387.3 5389.8 5393.7 3277.8 3284.9 3345.2 3355.3 3361.7 1085.4 1089.5 1106.0 1118.8 1125.5 12610.2 12802.4 12859.5 12884.7 12894.4 4753.3 4779.9 4783.8 4890.5 4933.6 10915.7 10926.9 10935.5 10938.2 10948.2 5411.1 5438.9 5441.2 5448.0 5448.9 4295.1 4406.9 4780.7 4904.2 4995.1 3940.1 4009.5 4036.1 4094.2 4111.0 1304.8 1307.6 1308.4 1331.9 1359.8 885.4 912.4 913.9 919.8 936.9 5677.5 5705.7 5805.9 5870.6 6106.4 464.9 469.1 473.7 492.4 492.6 3775.2 3927.3 3927.4 3936.1 4002.3 11170.7 11480.8 11607.2 11634.3 11637.4 11199.2 11397.0 11424.4 11429.8 11505.1 8248.4 8268.8 8415.2 8450.0 8492.5 5942.5 5952.4 6000.2 6041.6 6177.8 10160.4 10488.8 10508.1 10559.7 10577.9 10078.7 10473.8 10481.2 10668.6 10786.3 7066.9 7131.9 7188.3 8129.3 8274.4 7852.8 7926.5 8157.8 8339.9 8441.0 7870.5 7933.1 8003.1 8146.2 8255.1 7760.1 7871.2 7886.0 7898.1 7899.2 6924.7 7030.9 7034.7 7037.6 7040.3 4899.4 4937.5 4970.9 4980.7 5025.7 5316.4 5316.4 5334.1 5440.3 5536.8 17:37:02 INFO - PROCESS | 13389 | 17:37:02 INFO - PROCESS | 13389 | [#4] prototype.html Cycles:180 Average:4573.79 Median:5196.93 stddev:1330.45 (25.6%) stddev-sans-first:1295.28 17:37:02 INFO - PROCESS | 13389 | Values: 318.8 333.9 339.3 340.3 343.4 5179.6 5231.5 5283.7 5289.9 5340.4 5206.6 5235.9 5246.2 5246.5 5259.3 4114.9 4118.0 4124.2 4124.8 4139.3 3989.0 4060.8 4084.8 4113.4 4135.6 4021.4 4048.4 4051.7 4057.3 4101.4 4096.3 4106.1 4109.2 4111.9 4150.2 3660.7 3662.7 3687.7 3690.6 3692.1 4900.2 5128.3 5139.3 5142.2 5187.2 4658.8 4681.8 4716.5 4717.3 4724.1 5230.3 5405.7 5466.4 5475.6 5487.7 3890.9 3900.3 3934.8 3945.4 3961.2 5375.5 5601.7 5689.2 5729.5 5739.9 3892.8 3926.9 3929.6 3932.0 3962.3 4115.7 4130.8 4133.1 4136.4 4143.6 4568.3 4650.6 4729.3 4737.6 4754.1 5524.4 5534.3 5538.2 5542.5 5575.0 1394.6 1419.5 1420.9 1427.4 1428.5 856.2 925.2 925.7 936.4 939.5 4677.5 4731.6 4754.8 4782.5 4788.7 4959.7 4971.7 4977.8 5003.4 5009.8 4700.2 4728.9 4737.4 4754.3 4835.2 2897.9 2948.6 2965.2 2969.9 2973.2 5673.3 5693.3 5694.2 5699.1 5741.6 5631.2 5723.2 5748.4 5748.7 5823.3 5636.9 5646.5 5683.3 5686.3 5689.1 5367.2 5594.4 5611.3 5634.6 5658.9 5554.6 5563.9 5568.4 5589.7 5613.0 5419.2 5538.6 5589.0 5725.7 5758.9 4046.5 4068.1 4068.8 4070.2 4071.9 5660.2 5665.2 5674.3 5679.0 5683.1 5304.4 5405.7 5439.6 5475.0 5522.3 5468.5 5477.7 5479.8 5484.9 5493.3 5309.7 5476.7 5500.3 5516.7 5524.8 5402.9 5512.7 5559.2 5569.4 5579.6 5414.9 5439.6 5449.8 5450.0 5454.0 17:37:02 INFO - PROCESS | 13389 | 17:37:02 INFO - PROCESS | 13389 | [#5] yui.html Cycles:180 Average:20647.97 Median:4501.86 stddev:29245.78 (649.6%) stddev-sans-first:29289.59 17:37:02 INFO - PROCESS | 13389 | Values: 730.5 787.8 793.8 803.2 836.7 16088.8 16976.7 16986.2 16991.1 17019.3 15327.8 15486.8 15513.9 15522.5 15530.5 643.7 659.3 761.6 770.2 791.5 773.5 780.4 781.7 784.0 789.4 820.0 820.8 822.2 822.3 822.4 672.2 686.0 809.9 819.1 819.8 611.6 613.6 613.9 615.5 616.6 16019.8 16130.9 16132.2 16146.2 16164.0 14191.9 14309.7 14527.9 14673.6 14700.9 13167.7 13211.4 13466.6 13626.3 13822.4 4541.4 4605.6 4747.1 4824.2 4851.9 81325.6 82097.0 84163.0 84314.6 84978.0 10711.5 10857.3 11185.7 11265.8 11823.6 22365.9 22369.4 22416.0 22423.0 22451.6 8103.1 8369.2 8563.1 8647.3 8810.6 4451.1 4660.7 4672.7 4687.1 4723.3 3382.8 3468.4 3483.8 3486.0 3494.4 556.9 563.0 578.8 579.6 586.8 563.7 610.3 687.6 698.3 701.6 8655.2 9252.8 9323.9 9342.7 9511.6 572.3 659.8 678.1 702.0 713.5 4292.0 4440.8 4447.4 4450.6 4462.4 102182.0 104280.8 107077.0 121225.5 125902.0 97966.0 98876.5 99324.0 99338.5 100880.0 55196.0 61348.4 86055.6 86602.0 87704.6 10070.8 10274.6 10495.3 10636.6 10681.6 48104.0 48586.0 50749.0 51155.0 51182.0 65265.0 66025.7 67149.7 69128.7 75068.0 13330.8 13387.7 13439.5 13690.4 14256.2 15097.6 15196.0 15429.0 16420.6 16781.3 13761.8 13905.9 14033.9 14422.6 15283.5 13404.3 13831.0 13909.0 13933.9 14558.5 13524.9 13574.8 13671.7 14223.9 15122.6 10481.5 10774.5 11218.4 11389.0 11631.4 9419.0 10247.6 10433.1 10550.6 10604.5 17:37:02 INFO - PROCESS | 13389 | -------- Summary: end -------- 17:37:02 INFO - PROCESS | 13389 | 17:37:03 INFO - TEST-INFO | 13389: exit 0 17:37:03 INFO - TEST-OK | dromaeo_css | took 1116128ms 17:37:03 INFO - TEST-START | kraken 17:37:03 INFO - operating with platform_type : linux_ 17:37:03 INFO - Initialising browser for kraken test... 17:37:03 INFO - TEST-INFO | started process 13702 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwWHYee/profile http://localhost:48700/getInfo.html) 17:37:07 INFO - PROCESS | 13702 | __metrics Screen width/height:1600/1200 17:37:07 INFO - PROCESS | 13702 | colorDepth:24 17:37:07 INFO - PROCESS | 13702 | Browser inner width/height: 1024/697 17:37:07 INFO - PROCESS | 13702 | __metrics 17:37:08 INFO - PROCESS | 13702 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:37:08 INFO - PROCESS | 13702 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:37:09 INFO - PROCESS | 13702 | console.error: PushService: 17:37:09 INFO - PROCESS | 13702 | stateChangeProcessEnqueue: Error transitioning state 17:37:09 INFO - PROCESS | 13702 | UnknownError 17:37:09 INFO - TEST-INFO | 13702: exit 0 17:37:09 INFO - Browser initialized. 17:37:09 INFO - Running cycle 1/1 for kraken test... 17:37:09 INFO - TEST-INFO | started process 13784 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwWHYee/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:37:21 INFO - PROCESS | 13784 | RSS: Main: 174043136 17:37:21 INFO - PROCESS | 13784 | 17:37:24 INFO - PROCESS | 13784 | Cycle 1(1): loaded http://localhost:48700/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48700/tests/kraken/driver.html?testName=audio-beat-detection) 17:37:25 INFO - PROCESS | 13784 | RSS: Main: 232456192 17:37:25 INFO - PROCESS | 13784 | 17:37:27 INFO - PROCESS | 13784 | Cycle 1(1): loaded http://localhost:48700/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48700/tests/kraken/driver.html?testName=audio-dft) 17:37:28 INFO - PROCESS | 13784 | RSS: Main: 216375296 17:37:28 INFO - PROCESS | 13784 | 17:37:31 INFO - PROCESS | 13784 | Cycle 1(1): loaded http://localhost:48700/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48700/tests/kraken/driver.html?testName=audio-fft) 17:37:32 INFO - PROCESS | 13784 | RSS: Main: 297811968 17:37:32 INFO - PROCESS | 13784 | 17:37:34 INFO - PROCESS | 13784 | Cycle 1(1): loaded http://localhost:48700/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48700/tests/kraken/driver.html?testName=audio-oscillator) 17:37:34 INFO - PROCESS | 13784 | RSS: Main: 208113664 17:37:34 INFO - PROCESS | 13784 | 17:37:37 INFO - PROCESS | 13784 | Cycle 1(1): loaded http://localhost:48700/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48700/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:37:37 INFO - PROCESS | 13784 | RSS: Main: 211955712 17:37:37 INFO - PROCESS | 13784 | 17:37:40 INFO - PROCESS | 13784 | Cycle 1(1): loaded http://localhost:48700/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48700/tests/kraken/driver.html?testName=imaging-darkroom) 17:37:41 INFO - PROCESS | 13784 | RSS: Main: 248946688 17:37:41 INFO - PROCESS | 13784 | 17:37:44 INFO - PROCESS | 13784 | Cycle 1(1): loaded http://localhost:48700/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48700/tests/kraken/driver.html?testName=imaging-desaturate) 17:37:45 INFO - PROCESS | 13784 | RSS: Main: 248070144 17:37:45 INFO - PROCESS | 13784 | 17:37:48 INFO - PROCESS | 13784 | Cycle 1(1): loaded http://localhost:48700/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48700/tests/kraken/driver.html?testName=json-parse-financial) 17:37:48 INFO - PROCESS | 13784 | RSS: Main: 248516608 17:37:48 INFO - PROCESS | 13784 | 17:37:50 INFO - PROCESS | 13784 | Cycle 1(1): loaded http://localhost:48700/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48700/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:37:50 INFO - PROCESS | 13784 | RSS: Main: 210239488 17:37:50 INFO - PROCESS | 13784 | 17:37:52 INFO - PROCESS | 13784 | Cycle 1(1): loaded http://localhost:48700/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48700/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:37:53 INFO - PROCESS | 13784 | RSS: Main: 218025984 17:37:53 INFO - PROCESS | 13784 | 17:37:55 INFO - PROCESS | 13784 | Cycle 1(1): loaded http://localhost:48700/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48700/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:37:55 INFO - PROCESS | 13784 | RSS: Main: 221704192 17:37:55 INFO - PROCESS | 13784 | 17:37:58 INFO - PROCESS | 13784 | Cycle 1(1): loaded http://localhost:48700/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48700/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:37:59 INFO - PROCESS | 13784 | RSS: Main: 223354880 17:37:59 INFO - PROCESS | 13784 | 17:38:01 INFO - PROCESS | 13784 | Cycle 1(1): loaded http://localhost:48700/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48700/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:38:02 INFO - PROCESS | 13784 | RSS: Main: 221442048 17:38:02 INFO - PROCESS | 13784 | 17:38:04 INFO - PROCESS | 13784 | Cycle 1(1): loaded http://localhost:48700/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48700/tests/kraken/driver.html?testName=ai-astar) 17:38:04 INFO - PROCESS | 13784 | RSS: Main: 272023552 17:38:04 INFO - PROCESS | 13784 | 17:38:04 INFO - PROCESS | 13784 | __start_tp_report 17:38:04 INFO - PROCESS | 13784 | _x_x_mozilla_page_load 17:38:04 INFO - PROCESS | 13784 | _x_x_mozilla_page_load_details 17:38:04 INFO - PROCESS | 13784 | |i|pagename|runs| 17:38:04 INFO - PROCESS | 13784 | |0;ai-astar;112;111;110;111;110;111;111;110;111;111 17:38:04 INFO - PROCESS | 13784 | |1;audio-beat-detection;149;120;120;161;122;119;128;129;164;124 17:38:04 INFO - PROCESS | 13784 | |2;audio-dft;161;163;162;160;161;163;161;162;162;161 17:38:04 INFO - PROCESS | 13784 | |3;audio-fft;75;76;76;112;77;77;75;75;111;76 17:38:04 INFO - PROCESS | 13784 | |4;audio-oscillator;82;82;108;83;82;83;106;83;82;111 17:38:04 INFO - PROCESS | 13784 | |5;imaging-gaussian-blur;117;118;117;117;117;118;118;117;117;118 17:38:04 INFO - PROCESS | 13784 | |6;imaging-darkroom;145;146;145;145;146;146;146;145;146;146 17:38:04 INFO - PROCESS | 13784 | |7;imaging-desaturate;95;96;95;95;95;96;96;96;96;96 17:38:04 INFO - PROCESS | 13784 | |8;json-parse-financial;52;52;50;50;53;52;52;53;52;52 17:38:04 INFO - PROCESS | 13784 | |9;json-stringify-tinderbox;61;62;61;61;62;61;61;61;62;67 17:38:04 INFO - PROCESS | 13784 | |10;stanford-crypto-aes;86;78;79;79;83;83;78;79;79;78 17:38:04 INFO - PROCESS | 13784 | |11;stanford-crypto-ccm;133;123;122;126;126;125;130;132;170;127 17:38:04 INFO - PROCESS | 13784 | |12;stanford-crypto-pbkdf2;164;165;159;161;169;159;160;160;159;162 17:38:04 INFO - PROCESS | 13784 | |13;stanford-crypto-sha256-iterative;65;74;65;65;68;67;64;64;63;67 17:38:04 INFO - PROCESS | 13784 | __end_tp_report 17:38:04 INFO - PROCESS | 13784 | __start_cc_report 17:38:04 INFO - PROCESS | 13784 | _x_x_mozilla_cycle_collect,1681 17:38:04 INFO - PROCESS | 13784 | __end_cc_report 17:38:04 INFO - PROCESS | 13784 | __startTimestamp1473813484328__endTimestamp 17:38:04 INFO - PROCESS | 13784 | 17:38:04 INFO - PROCESS | 13784 | ------- Summary: start ------- 17:38:04 INFO - PROCESS | 13784 | Number of tests: 14 17:38:04 INFO - PROCESS | 13784 | 17:38:04 INFO - PROCESS | 13784 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:0.63 (0.6%) stddev-sans-first:0.50 17:38:04 INFO - PROCESS | 13784 | Values: 112.0 111.0 110.0 111.0 110.0 111.0 111.0 110.0 111.0 111.0 17:38:04 INFO - PROCESS | 13784 | 17:38:04 INFO - PROCESS | 13784 | [#1] audio-beat-detection Cycles:10 Average:133.60 Median:128.50 stddev:17.56 (13.7%) stddev-sans-first:17.72 17:38:04 INFO - PROCESS | 13784 | Values: 149.0 120.0 120.0 161.0 122.0 119.0 128.0 129.0 164.0 124.0 17:38:04 INFO - PROCESS | 13784 | 17:38:04 INFO - PROCESS | 13784 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 17:38:04 INFO - PROCESS | 13784 | Values: 161.0 163.0 162.0 160.0 161.0 163.0 161.0 162.0 162.0 161.0 17:38:04 INFO - PROCESS | 13784 | 17:38:04 INFO - PROCESS | 13784 | [#3] audio-fft Cycles:10 Average:83.00 Median:76.00 stddev:15.04 (19.8%) stddev-sans-first:15.67 17:38:04 INFO - PROCESS | 13784 | Values: 75.0 76.0 76.0 112.0 77.0 77.0 75.0 75.0 111.0 76.0 17:38:04 INFO - PROCESS | 13784 | 17:38:04 INFO - PROCESS | 13784 | [#4] audio-oscillator Cycles:10 Average:90.20 Median:82.00 stddev:12.58 (15.3%) stddev-sans-first:12.99 17:38:04 INFO - PROCESS | 13784 | Values: 82.0 82.0 108.0 83.0 82.0 83.0 106.0 83.0 82.0 111.0 17:38:04 INFO - PROCESS | 13784 | 17:38:04 INFO - PROCESS | 13784 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 17:38:04 INFO - PROCESS | 13784 | Values: 117.0 118.0 117.0 117.0 117.0 118.0 118.0 117.0 117.0 118.0 17:38:04 INFO - PROCESS | 13784 | 17:38:04 INFO - PROCESS | 13784 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 17:38:04 INFO - PROCESS | 13784 | Values: 145.0 146.0 145.0 145.0 146.0 146.0 146.0 145.0 146.0 146.0 17:38:04 INFO - PROCESS | 13784 | 17:38:04 INFO - PROCESS | 13784 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 17:38:04 INFO - PROCESS | 13784 | Values: 95.0 96.0 95.0 95.0 95.0 96.0 96.0 96.0 96.0 96.0 17:38:04 INFO - PROCESS | 13784 | 17:38:04 INFO - PROCESS | 13784 | [#8] json-parse-financial Cycles:10 Average:51.80 Median:52.00 stddev:1.03 (2.0%) stddev-sans-first:1.09 17:38:04 INFO - PROCESS | 13784 | Values: 52.0 52.0 50.0 50.0 53.0 52.0 52.0 53.0 52.0 52.0 17:38:04 INFO - PROCESS | 13784 | 17:38:04 INFO - PROCESS | 13784 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:61.50 stddev:1.85 (3.0%) stddev-sans-first:1.94 17:38:04 INFO - PROCESS | 13784 | Values: 61.0 62.0 61.0 61.0 62.0 61.0 61.0 61.0 62.0 67.0 17:38:04 INFO - PROCESS | 13784 | 17:38:04 INFO - PROCESS | 13784 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:79.00 stddev:2.78 (3.5%) stddev-sans-first:2.01 17:38:04 INFO - PROCESS | 13784 | Values: 86.0 78.0 79.0 79.0 83.0 83.0 78.0 79.0 79.0 78.0 17:38:04 INFO - PROCESS | 13784 | 17:38:04 INFO - PROCESS | 13784 | [#11] stanford-crypto-ccm Cycles:10 Average:131.40 Median:128.50 stddev:14.03 (10.9%) stddev-sans-first:14.87 17:38:04 INFO - PROCESS | 13784 | Values: 133.0 123.0 122.0 126.0 126.0 125.0 130.0 132.0 170.0 127.0 17:38:04 INFO - PROCESS | 13784 | 17:38:04 INFO - PROCESS | 13784 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.80 Median:161.50 stddev:3.29 (2.0%) stddev-sans-first:3.40 17:38:04 INFO - PROCESS | 13784 | Values: 164.0 165.0 159.0 161.0 169.0 159.0 160.0 160.0 159.0 162.0 17:38:04 INFO - PROCESS | 13784 | 17:38:04 INFO - PROCESS | 13784 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.00 stddev:3.16 (4.8%) stddev-sans-first:3.32 17:38:04 INFO - PROCESS | 13784 | Values: 65.0 74.0 65.0 65.0 68.0 67.0 64.0 64.0 63.0 67.0 17:38:04 INFO - PROCESS | 13784 | -------- Summary: end -------- 17:38:04 INFO - PROCESS | 13784 | 17:38:05 INFO - TEST-INFO | 13784: exit 0 17:38:05 INFO - TEST-OK | kraken | took 62385ms 17:38:05 INFO - SUITE-END | took 1178s 17:38:05 INFO - Completed test suite (00:19:38) 17:38:05 INFO - javascript benchmark 17:38:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2955.4236923799854, 3002.924926876827, 3009.804362716422, 3043.6499802522717, 3058.9293747188485, 5228.189630607252, 5295.4704529547025, 5305.787768489261, 5413.702246376452, 5431.239626452295, 5299.761510732017, 5322.281491998579, 5360.785568577252, 5387.488188622085, 5443.2107344435035, 4756.500567440421, 4802.015586804697, 4806.735629540374, 4825.710457372551, 4835.613150947934, 4923.286123512089, 4957.5786058185095, 4958.851234462972, 4959.727215003173, 4993.101241776479, 4662.114198302312, 4695.718256904596, 4707.129181101507, 4818.807247710088, 4829.1307564638355, 4732.02993386355, 4785.353977213066, 4796.544328288807, 4872.025594881003, 4888.826681596427, 4736.810527578893, 4775.116603428377, 4775.785089670973, 4849.709017458964, 4852.878678033042, 5302.151655735102, 5321.042212401766, 5321.494458026481, 5324.068288049576, 5330.840074797762, 5529.170624406331, 5583.8604034899045, 5650.434956504317, 5651.717414129318, 5709.74306156224, 5720.8283751487525, 5744.942550574524, 5746.511546518551, 5801.0, 5805.709714514257, 5347.358317001946, 5352.785888564453, 5358.169483730028, 5368.382635996872, 5368.516833485005, 5523.502884740393, 5631.802886898939, 5815.069588865761, 5841.795537156264, 5863.120531920246, 5604.887902241932, 5637.0, 5659.660420374791, 5719.571032172604, 5726.856828579319, 5713.314402271754, 5758.769649213985, 5764.365919748824, 5767.279090113736, 5768.567357448208, 5476.424975377608, 5534.972325138429, 5705.058665320259, 5712.857178570569, 5718.542516598662, 5667.291588551431, 5675.432456754292, 5739.339975902824, 5739.885202295931, 5741.827745167651, 4371.125774845043, 4383.60547550722, 4386.232409328419, 4431.645468362523, 4439.178751930903, 3875.2636998970106, 3879.7478163919254, 3899.3760998240145, 3919.3141200289833, 3929.3713005918917, 5267.657602255841, 5317.973410133002, 5348.197770334481, 5349.759260833272, 5455.372632147354, 5690.715464226855, 5702.54379649627, 5703.7148142592705, 5704.743286552115, 5705.115707065412, 5334.839954801362, 5380.192971054373, 5382.596305277041, 5388.299521062237, 5450.264214331015, 4855.223164293696, 4856.95143048565, 4899.681520701143, 4900.117978763786, 4914.164592019365, 5743.9425605744245, 5757.6833274169485, 5759.596828222068, 5760.135979603093, 5819.388964158702, 5664.603477756682, 5673.092305231144, 5678.630888992202, 5683.204351390726, 5688.345840228261, 5497.697626630574, 5505.366882808368, 5663.263775709132, 5663.575231857545, 5757.740901659352, 5516.779328826802, 5522.337319521523, 5534.86162845916, 5598.468145526169, 5607.046802043581, 5569.443055694398, 5586.553075753849, 5598.048331783525, 5601.187827765033, 5602.607817452902, 5424.267723857387, 5445.074337362737, 5457.263269458573, 5517.117261238343, 5526.751296191601, 5446.373667028184, 5473.288472498709, 5474.479924407175, 5522.22688823573, 5541.972290138524, 5417.620766546304, 5418.485243901823, 5418.674879507243, 5421.457854214547, 5423.945760542502, 5388.515033646991, 5518.034343989705, 5536.370169275082, 5548.889022219452, 5554.833354999357, 5360.544353729977, 5387.218853266333, 5427.810026649048, 5438.782448702008, 5440.183972404171], "value": 5218.979929013465, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.4715031580205, 595.8182754259951, 598.0640297933734, 610.1762620462374, 614.0237023133219, 33417.0, 44467.555324446745, 45524.544754552444, 45600.543994560045, 45646.77176614112, 47022.0, 47428.76285618576, 47507.0, 47578.28632570514, 47614.761926190404, 9049.864252036225, 9109.681161159328, 9113.0, 9122.498262595554, 9219.861702074475, 9018.59416326267, 9080.500572468512, 9092.090790920922, 9116.954415227949, 9122.954385228064, 9094.36339456235, 9165.58754856033, 9170.082991700843, 9170.312226582999, 9177.265818734486, 9094.54527273637, 9131.497767622777, 9132.634694612207, 9137.269018478506, 9155.267578593763, 8992.730218093468, 9027.954860225656, 9028.41315314509, 9042.547872606343, 9050.864237036383, 42529.36205956913, 42944.0, 42968.0, 42969.78515107436, 42979.57020429787, 3654.6162652921325, 3655.141041855162, 3678.4666223397458, 3752.587215406303, 3871.5741268460447, 31900.0, 31979.680203197902, 31998.680013199802, 32082.839585802154, 32474.675253247402, 4144.8134833932545, 4301.501364651799, 4305.526392096866, 4327.567243275679, 4399.802008909607, 343603.0, 345482.0, 346613.0, 348748.0, 348844.0, 58308.0, 58740.412595874346, 58756.41243587595, 58837.41162588405, 58868.41131588715, 53455.46544534505, 54089.94325425609, 60017.99640072003, 60030.39969600248, 60263.0, 15581.610459738371, 16463.91768041152, 16629.251683674265, 16647.583810404838, 16655.83344166567, 12837.0, 12966.481340746453, 12967.0, 12973.805392919114, 12989.610311690665, 15174.317155728018, 15317.23413829304, 16437.83562164363, 16833.242504087346, 16850.32598696063, 5748.913766293509, 5852.385499522574, 5855.066385048283, 5914.378990206053, 6106.572539922163, 876.1763941894599, 959.822432849925, 987.1855719031828, 1057.5188289328337, 1084.951177197028, 33002.0, 33099.83450082734, 33128.50307245393, 33181.50227746586, 33554.0, 1083.3987137138806, 1092.3445932440632, 1141.9086473082134, 1150.6030419505257, 1177.7291223018753, 16267.349306027627, 16947.0, 17064.146792660318, 17066.829331706525, 17200.655986880192, 530776.0, 533543.9747230357, 533876.0, 534416.0, 535135.0, 58367.24898253059, 58981.0, 58988.11517827236, 58999.0, 59037.0, 1307.1438207973792, 1307.6469353274563, 1350.554317075343, 1358.5041459867077, 1361.5438827992534, 30164.0, 31368.0, 32060.358792824478, 32389.838050809594, 32609.836950815094, 51721.7413912928, 52093.0, 52158.0, 52221.0, 52249.0, 356208.0, 357012.0, 358362.0, 359181.0, 359291.0, 36450.27099458049, 37212.73025152746, 37911.62088379081, 41897.0, 42175.36736949009, 40288.0, 40412.79793601013, 47150.76424617855, 47408.525914740414, 47562.76218618885, 40336.0, 41073.794631026656, 41897.58102418937, 42064.78967605143, 42985.0, 41229.96925076897, 41539.58460415478, 41566.16867662569, 42615.7869210652, 42818.0, 40110.0, 40559.986000350225, 41203.7939810299, 41307.0, 44563.33155002613, 33983.83008085043, 36792.0, 37469.0, 37636.24727505489, 38232.235355292185, 27814.44371112607, 28092.578611321256, 28321.858390708738, 28439.573406398507, 28559.0], "value": 20094.411060885028, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.6177330010042, 398.1360447828213, 403.95556488786235, 407.1429640606522, 414.05182132915627, 13627.182369057851, 14852.554423367303, 18995.0, 19536.413907582795, 19994.900025499854, 19183.23267069319, 19355.709664355047, 19736.111874965623, 19779.505512362197, 19796.70304945427, 5380.650257733254, 5679.148127780824, 5933.110033494967, 5934.109883517485, 5935.347111817697, 6483.773067942623, 6690.464762818987, 6690.83272918176, 6711.6979735912, 6720.227173875018, 6468.353164683517, 6544.851158539017, 6604.2405123410945, 6659.93340066598, 6672.733090676367, 6370.840728981766, 6548.214214294291, 6586.637734924578, 6588.439982601484, 6588.571742836724, 5795.275590551181, 5831.708414579254, 5835.824925252206, 5836.737346819404, 5838.474537291664, 22849.0, 23414.76585234143, 23426.648600271008, 23615.409614759596, 23684.28947131589, 2329.2895666821614, 2370.0401337458356, 2389.0443822470975, 2427.5630386530415, 2544.821862469628, 13649.454021839114, 14677.706445871023, 14990.100593964396, 15405.22973851303, 15440.45958391451, 1803.9729404058949, 1864.813518648138, 1885.283592234942, 1931.9323823666105, 1962.5093726568357, 53918.73040634772, 73988.63005684938, 77581.61209193974, 78128.60935695341, 86639.99999999937, 10508.684739457829, 10626.681199564026, 10814.837777433344, 10899.1280697544, 11191.496382662799, 15237.238138093051, 15301.693966120616, 15302.387904483696, 15321.46374876874, 15342.76985845191, 7808.141104478503, 8181.668224556092, 8192.221738934792, 8382.790430239293, 8436.578171091543, 7923.960380198062, 7954.164812694699, 7977.242161994601, 8191.631376588068, 8195.180481951757, 6626.801195964129, 6713.597184168965, 6729.22613899398, 6766.357196066366, 6934.47991400647, 1839.8160183981763, 1912.9713054304198, 1919.280269898788, 1925.3261358524405, 1973.1219607274911, 885.5970533407284, 928.7910220200536, 1009.5557954500143, 1011.9691523886008, 1091.5682329741117, 19771.0, 19791.703124453146, 20470.283540076027, 20477.18091276362, 20525.38423847287, 968.2737946540095, 980.3921568627496, 995.2734503812258, 1004.5128112865254, 1071.989280107189, 10999.945000275107, 11481.253718508271, 11494.94252528732, 11498.827517587242, 11500.654980350602, 459209.0, 469048.0, 473126.0, 474126.0, 475029.0, 79859.60070199613, 79973.0, 80016.0, 80450.59774701206, 80973.0, 1018.8013337399136, 1062.4103622489438, 1064.180580952662, 1073.5705717712822, 1078.191356482638, 17282.481525554253, 17522.73715894237, 18034.909825450788, 18049.0, 18278.17748201361, 39851.80074099611, 41012.15445304909, 41713.79143104265, 42104.57895421129, 42796.38357314578, 53116.46883531115, 53897.730511347196, 55013.0, 55577.72211138919, 58618.12072818826, 8412.747617571482, 8634.654613815377, 8638.870416943877, 8804.0, 8846.955765221133, 9926.908040115726, 12132.454039568418, 13265.0, 13421.530246441718, 13957.441702331793, 11150.721231969266, 11253.943730281297, 11386.43067846621, 11686.94156529212, 11947.641570752892, 11196.888031119584, 11422.31466112036, 11650.592229271935, 12082.818757718465, 12111.0, 11681.299122052704, 12064.51741930348, 12144.089193310714, 12179.87820121823, 12275.140740148105, 7869.48848324857, 8675.30597552207, 8699.695510657097, 8830.42602230853, 8892.822143557221, 11295.096392288762, 11440.542378304775, 11638.70903227426, 11718.23831450953, 11984.880151198377], "value": 9474.18602249907, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1345.192884269439, 1487.6429656882349, 1500.7973923520326, 1655.7185278502654, 1790.489710432527, 7747.845043099134, 8489.872651910226, 8849.424787388814, 8873.866891996626, 8892.955535222314, 8813.735587932357, 8985.91014089859, 8986.2810975122, 8995.640174393033, 9000.504972226541, 2323.74438811731, 2364.858108513486, 2367.562001029806, 2372.418757404438, 2373.1456675596773, 2243.8653680779207, 2280.600894843404, 2338.368640467073, 2341.637046257833, 2343.8593684378993, 2392.1149174805346, 2400.5558971590312, 2418.8669623170717, 2418.8790560471994, 2425.527022230666, 2279.09975559653, 2298.276043046443, 2299.6895419118373, 2301.1255722825385, 2339.9649005264764, 2272.1025195047864, 2275.306031660343, 2277.760835112306, 2280.2589158523547, 2285.6914316567218, 8743.693970711058, 8963.596638151299, 8966.193042626195, 9026.638934442615, 9037.367384283103, 5146.459621739701, 5380.2736630555155, 5387.299651045339, 5389.78440862365, 5393.73031348435, 3277.8197199154038, 3284.8521816518314, 3345.2305969627123, 3355.312161006988, 3361.6806403391884, 1085.365061439059, 1089.4661615808277, 1105.9533019897237, 1118.7650593375402, 1125.5104029747085, 12610.180338277982, 12802.42389092493, 12859.549915752903, 12884.742305153844, 12894.419751111316, 4753.2684948979395, 4779.880502987384, 4783.832565860178, 4890.535399137077, 4933.580645645088, 10915.727106822393, 10926.890731092588, 10935.507902144423, 10938.234323597431, 10948.178886583539, 5411.053065713484, 5438.945610543923, 5441.183822426588, 5447.972760136253, 5448.891022179613, 4295.076558539929, 4406.889827754332, 4780.737059461763, 4904.190808516626, 4995.050940321327, 3940.113474468279, 4009.51885773709, 4036.1120553478186, 4094.181163767199, 4111.033907031845, 1304.784710522772, 1307.5815738963631, 1308.4046758724758, 1331.9134256273505, 1359.7552440560596, 885.4112015509743, 912.4069354919355, 913.8903331600118, 919.8068405634758, 936.9437833729997, 5677.545796336283, 5705.71471426427, 5805.88388232233, 5870.618409803349, 6106.419890110433, 464.8512476007713, 469.10167030137586, 473.7134033909504, 492.3746841511261, 492.56900212314224, 3775.1505911169766, 3927.3127202739406, 3927.351986922183, 3936.1340505088833, 4002.2795896738285, 11170.720731981766, 11480.770384592428, 11607.245529040585, 11634.301941883514, 11637.359945202927, 11199.21605487608, 11397.0, 11424.42877856104, 11429.771404571862, 11505.137114716263, 8248.422610417214, 8268.751937441766, 8415.200555947175, 8450.0, 8492.490450572985, 5942.465178133989, 5952.375000624872, 6000.189974353581, 6041.577089603686, 6177.84555386119, 10160.390376577428, 10488.842667359842, 10508.054275115277, 10559.736006599896, 10577.9471102644, 10078.748031299276, 10473.842892356468, 10481.161507079567, 10668.573257069631, 10786.298890572089, 7066.929330706627, 7131.8930216045765, 7188.317109874553, 8129.309008734087, 8274.420790544846, 7852.84294314122, 7926.48477848938, 8157.8368432632205, 8339.916600834156, 8440.95779521123, 7870.527768333918, 7933.087694915159, 8003.119656837627, 8146.185381461806, 8255.050669173123, 7760.146383897654, 7871.173526779835, 7886.0, 7898.131205567268, 7899.249571290718, 6924.6537673117155, 7030.929690703232, 7034.683439245144, 7037.577745335297, 7040.331168538981, 4899.387576552931, 4937.456879743298, 4970.8757281068265, 4980.726060066586, 5025.74871256443, 5316.415194328543, 5316.415194328698, 5334.146536554133, 5440.292761940922, 5536.750846211849], "value": 4596.763635731695, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.837392929606, 333.92143376892636, 339.3315169116839, 340.3227577121529, 343.36991620376614, 5179.559737422323, 5231.529162375386, 5283.709395983219, 5289.889123284105, 5340.424574750448, 5206.609504287175, 5235.921461178085, 5246.160614301703, 5246.481688789383, 5259.342582177228, 4114.855980040699, 4117.991092182419, 4124.237016152014, 4124.8143833527565, 4139.254934111858, 3988.9601103989025, 4060.822361515172, 4084.836606535735, 4113.403556484308, 4135.627793498585, 4021.396790481422, 4048.3725022621393, 4051.7163798534116, 4057.3305404608204, 4101.405296232045, 4096.344584866422, 4106.096658735073, 4109.157622687342, 4111.938320925188, 4150.211459822624, 3660.7071434285194, 3662.706983441345, 3687.723420743428, 3690.5940346561856, 3692.095436618046, 4900.215965445547, 5128.333316668846, 5139.254808052849, 5142.1772516397195, 5187.247849061865, 4658.813647454098, 4681.836135735267, 4716.52834716529, 4717.315989181549, 4724.149653062447, 5230.293910322096, 5405.675659460445, 5466.398696143461, 5475.616706830523, 5487.722595123019, 3890.922181556353, 3900.3369427197445, 3934.8229329680235, 3945.3884647879627, 3961.187956468917, 5375.489328513785, 5601.747921343549, 5689.236336735626, 5729.484346408802, 5739.885202295973, 3892.8053597320586, 3926.8821935341984, 3929.626685464876, 3931.9973406781087, 3962.2669806085964, 4115.670746340285, 4130.752154870717, 4133.132042271157, 4136.44158038667, 4143.647789937889, 4568.337591049346, 4650.581447669659, 4729.2906064089975, 4737.620990320766, 4754.144254034307, 5524.364698059694, 5534.335879694462, 5538.224648549206, 5542.501174894279, 5575.0, 1394.5607133753037, 1419.5031738891512, 1420.94849811139, 1427.3862239237021, 1428.4643258777958, 856.1609622569792, 925.167349385545, 925.6898938855559, 936.3773090894615, 939.5114540438933, 4677.462091859412, 4731.574158325767, 4754.78603462845, 4782.497837727058, 4788.688735232199, 4959.7272150032095, 4971.676841005323, 4977.751112444364, 5003.424606170264, 5009.847735020966, 4700.226866148989, 4728.905421891612, 4737.38414006177, 4754.310624959361, 4835.178019736653, 2897.8985735499155, 2948.569943577363, 2965.1845742421006, 2969.940601187964, 2973.182374846934, 5673.290838645169, 5693.259876216065, 5694.174344719992, 5699.070304186848, 5741.62679425836, 5631.211630371751, 5723.198752174699, 5748.425157484302, 5748.683822389725, 5823.30120385548, 5636.887262254732, 5646.491815736604, 5683.2895888014, 5686.289213848269, 5689.065717656017, 5367.221752845738, 5594.356648985418, 5611.3266408031295, 5634.6337488063145, 5658.85852853682, 5554.555635549227, 5563.916541251965, 5568.443155684561, 5589.720513974366, 5612.971935140298, 5419.187121931742, 5538.556915446674, 5589.0, 5725.742341594721, 5758.884822303614, 4046.4941882264716, 4068.1253530491085, 4068.7558746475306, 4070.2266569351727, 4071.857484988011, 5660.15097735343, 5665.178549110438, 5674.2623458950075, 5678.971605141948, 5683.090705487102, 5304.427352733998, 5405.702686352289, 5439.619226654097, 5474.972625136849, 5522.282103326703, 5468.480494353189, 5477.740119772395, 5479.821838304783, 5484.945150548443, 5493.340799104133, 5309.7345132743985, 5476.726163691879, 5500.339959204921, 5516.724163791714, 5524.790083966445, 5402.891942161056, 5512.724363781875, 5559.2217089606675, 5569.359523654832, 5579.609427340048, 5414.891702165856, 5439.619226654097, 5449.809256675997, 5450.0, 5454.045542030208], "value": 4152.578791649384, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [730.4521608793408, 787.7794217619065, 793.8134538383481, 803.2489622203238, 836.6904245429184, 16088.83911160888, 16976.74534881978, 16986.235619397125, 16991.065491397967, 17019.31922723091, 15327.770083448757, 15486.845131548682, 15513.922430387833, 15522.5343239703, 15530.45643402481, 643.6910283064132, 659.2780904909141, 761.6344154805697, 770.1528318849277, 791.5290402210676, 773.4663082473104, 780.4302858912997, 781.6756046240831, 784.0, 789.4316092413482, 820.0323618130603, 820.7660816667251, 822.2106777493583, 822.3256929317962, 822.4325215601245, 672.1799404726202, 686.0361192524512, 809.8987626546682, 819.1112642782558, 819.7704642700023, 611.626907586372, 613.6164896939413, 613.8772245550863, 615.4522474997256, 616.5930485879298, 16019.839801601951, 16130.919345403197, 16132.193390330436, 16146.192690365435, 16164.0, 14191.858081419157, 14309.712125908718, 14527.92736036313, 14673.633159170999, 14700.926495367561, 13167.670808229776, 13211.40548675312, 13466.596002119952, 13626.250556219404, 13822.447102115902, 4541.364209010741, 4605.562471565196, 4747.050589882003, 4824.2040063389495, 4851.9272210916515, 81325.59337203336, 82096.9999999994, 84163.0, 84314.57842710809, 84978.0, 10711.517981690842, 10857.34855908648, 11185.66443006711, 11265.831012534654, 11823.586174483851, 22365.888170559043, 22369.44076398103, 22416.0, 22423.0, 22451.55096898053, 8103.1491693371345, 8369.246767790928, 8563.100874408223, 8647.264982476434, 8810.559472026373, 4451.132029254264, 4660.673752837337, 4672.719636821802, 4687.1328804171335, 4723.267893476448, 3382.7801192922875, 3468.4450487921813, 3483.790972541605, 3486.0413386318965, 3494.4408894576745, 556.9220309156722, 563.023154826376, 578.8147792706378, 579.6232448908244, 586.8298193523916, 563.6871536297394, 610.3255902227974, 687.608063403855, 698.2703075286338, 701.551007355293, 8655.17775811297, 9252.814943701089, 9323.906760932305, 9342.719718408458, 9511.57197926095, 572.324656904848, 659.8020593821834, 678.1252184681804, 701.9894701579481, 713.5183750968076, 4292.0, 4440.777961101932, 4447.421835161408, 4450.599446049871, 4462.352958820953, 102182.0, 104280.8125103011, 107077.0, 121225.48357905984, 125902.0, 97966.0, 98876.50561747146, 99324.0, 99338.50330748444, 100880.0, 55196.0, 61348.38651613516, 86055.56972215224, 86602.0, 87704.56147719221, 10070.8489372658, 10274.640387586698, 10495.279506805278, 10636.627718029831, 10681.57273709074, 48104.0, 48586.0, 50749.0, 51155.0, 51182.0, 65265.0, 66025.66987165033, 67149.66425167843, 69128.6543567279, 75068.0, 13330.800037999245, 13387.732245355233, 13439.529616463376, 13690.38393272325, 14256.215908125152, 15097.622559436102, 15196.0, 15429.0, 16420.589485262964, 16781.328746849988, 13761.79357309621, 13905.860941390456, 14033.929830350782, 14422.639434014234, 15283.541493755205, 13404.32978351098, 13831.0, 13909.0, 13933.860661393663, 14558.4904528341, 13524.93237533806, 13574.79637805414, 13671.726565468436, 14223.928880355532, 15122.621934451727, 10481.528331225265, 10774.515146818256, 11218.439078045902, 11389.0, 11631.360275184947, 9418.95290523543, 10247.641332553325, 10433.113185379025, 10550.630727924487, 10604.469776511298], "value": 7545.651101652181, "unit": "score"}], "name": "dromaeo_css", "value": 7232.460925976597, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 111.0, 110.0, 111.0, 110.0, 111.0, 111.0, 110.0, 111.0, 111.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 120.0, 120.0, 161.0, 122.0, 119.0, 128.0, 129.0, 164.0, 124.0], "value": 133.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 162.0, 160.0, 161.0, 163.0, 161.0, 162.0, 162.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 112.0, 77.0, 77.0, 75.0, 75.0, 111.0, 76.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 108.0, 83.0, 82.0, 83.0, 106.0, 83.0, 82.0, 111.0], "value": 90.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 50.0, 50.0, 53.0, 52.0, 52.0, 53.0, 52.0, 52.0], "value": 51.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 61.0, 62.0, 61.0, 61.0, 61.0, 62.0, 67.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 78.0, 79.0, 79.0, 83.0, 83.0, 78.0, 79.0, 79.0, 78.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 123.0, 122.0, 126.0, 126.0, 125.0, 130.0, 132.0, 170.0, 127.0], "value": 131.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 159.0, 161.0, 169.0, 159.0, 160.0, 160.0, 159.0, 162.0], "value": 161.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 74.0, 65.0, 65.0, 68.0, 67.0, 64.0, 64.0, 63.0, 67.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1491.1000000000001, "alertThreshold": 2.0}]} 17:38:06 INFO - Return code: 0 17:38:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:38:06 INFO - # TBPL SUCCESS # 17:38:06 INFO - Running post-action listener: _resource_record_post_action 17:38:06 INFO - [mozharness: 2016-09-14 00:38:06.128519Z] Finished run-tests step (success) 17:38:06 INFO - Running post-run listener: _resource_record_post_run 17:38:06 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 398331904; Read time: 12; Write time: 431200 17:38:06 INFO - TinderboxPrint: CPU usage
13.0% 17:38:06 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 17:38:06 INFO - TinderboxPrint: I/O write bytes / time
398,331,904 / 431,200 17:38:06 INFO - TinderboxPrint: CPU idle
8,296.2 (86.9%) 17:38:06 INFO - TinderboxPrint: CPU user
1,193.0 (12.5%) 17:38:06 INFO - TinderboxPrint: Swap in / out
0 / 0 17:38:06 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 111046656; Read time: 0; Write time: 143696 17:38:06 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 286957568; Read time: 0; Write time: 287500 17:38:06 INFO - Running post-run listener: _upload_blobber_files 17:38:06 INFO - Blob upload gear active. 17:38:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:38:06 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:38:06 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:38:06 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:38:07 INFO - (blobuploader) - INFO - Open directory for files ... 17:38:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:38:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:38:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:38:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:38:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:38:08 INFO - (blobuploader) - INFO - Done attempting. 17:38:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:38:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:38:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:38:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:38:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:38:11 INFO - (blobuploader) - INFO - Done attempting. 17:38:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:38:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:38:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:38:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:38:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:38:12 INFO - (blobuploader) - INFO - Done attempting. 17:38:12 INFO - (blobuploader) - INFO - Iteration through files over. 17:38:12 INFO - Return code: 0 17:38:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:38:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:38:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/57b03f70bcfc02d991ef9e32991f884e7543857e2aef2a11c4097a0e32bf76e395fb719cadf22be4e48b8f282d2b27a3ba17d90eaa0ab6b1499682b8b8956a2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b6d9461b523432fb09922c701aa13e652523c601f05698425e9d6f5330f0f2218ab0218a6129945583e36bda9fbe7499cdc4f7270c5a2f9e237cd8ab10ffcc72", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/68084f25ea9f72929f7a6153794068a9b6779b25c36d93c8568bfccc1ef0a503a25d9d25caf35420a7ce682016f6613bfa40d0095b791cc675ffe4299bf5aa84"} 17:38:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:38:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:38:12 INFO - Contents: 17:38:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/57b03f70bcfc02d991ef9e32991f884e7543857e2aef2a11c4097a0e32bf76e395fb719cadf22be4e48b8f282d2b27a3ba17d90eaa0ab6b1499682b8b8956a2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b6d9461b523432fb09922c701aa13e652523c601f05698425e9d6f5330f0f2218ab0218a6129945583e36bda9fbe7499cdc4f7270c5a2f9e237cd8ab10ffcc72", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/68084f25ea9f72929f7a6153794068a9b6779b25c36d93c8568bfccc1ef0a503a25d9d25caf35420a7ce682016f6613bfa40d0095b791cc675ffe4299bf5aa84"} 17:38:12 INFO - Running post-run listener: copy_logs_to_upload_dir 17:38:12 INFO - Copying logs to upload dir... 17:38:12 INFO - mkdir: /builds/slave/test/build/upload/logs 17:38:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.216975 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-09-13 17:38:10.419737) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-13 17:38:10.424169) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1473812252.13557-2082194890 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/57b03f70bcfc02d991ef9e32991f884e7543857e2aef2a11c4097a0e32bf76e395fb719cadf22be4e48b8f282d2b27a3ba17d90eaa0ab6b1499682b8b8956a2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b6d9461b523432fb09922c701aa13e652523c601f05698425e9d6f5330f0f2218ab0218a6129945583e36bda9fbe7499cdc4f7270c5a2f9e237cd8ab10ffcc72", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/68084f25ea9f72929f7a6153794068a9b6779b25c36d93c8568bfccc1ef0a503a25d9d25caf35420a7ce682016f6613bfa40d0095b791cc675ffe4299bf5aa84"} build_url:https://queue.taskcluster.net/v1/task/JuthdzfDSpSbZctGsn6BlA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011346 build_url: 'https://queue.taskcluster.net/v1/task/JuthdzfDSpSbZctGsn6BlA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/57b03f70bcfc02d991ef9e32991f884e7543857e2aef2a11c4097a0e32bf76e395fb719cadf22be4e48b8f282d2b27a3ba17d90eaa0ab6b1499682b8b8956a2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b6d9461b523432fb09922c701aa13e652523c601f05698425e9d6f5330f0f2218ab0218a6129945583e36bda9fbe7499cdc4f7270c5a2f9e237cd8ab10ffcc72", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/68084f25ea9f72929f7a6153794068a9b6779b25c36d93c8568bfccc1ef0a503a25d9d25caf35420a7ce682016f6613bfa40d0095b791cc675ffe4299bf5aa84"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-13 17:38:10.449931) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 17:38:10.450297) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1473812252.13557-2082194890 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004446 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 17:38:10.533561) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-13 17:38:10.533923) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-13 17:38:10.534231) ========= ========= Total master_lag: 0.17 =========