builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-025 starttime: 1471092830.83 results: success (0) buildid: 20160813030202 builduid: ca9acf50260347be84394eaa8979bdf1 revision: 2ed7e61b988d2466a61528f66050596ef272ebda ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-13 05:53:50.835044) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-13 05:53:50.835870) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-13 05:53:50.836212) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-13 05:53:50.866829) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 05:53:50.867392) ========= 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=232498196343f89f466a4a9a000001c8-1471090073.365106-58454676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-13 05:53:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 96.3M=0s 2016-08-13 05:53:51 (96.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.166510 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 05:53:51.062082) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 05:53:51.062434) ========= 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=232498196343f89f466a4a9a000001c8-1471090073.365106-58454676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017800 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 05:53:51.120072) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-13 05:53:51.120466) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2ed7e61b988d2466a61528f66050596ef272ebda --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 2ed7e61b988d2466a61528f66050596ef272ebda --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=232498196343f89f466a4a9a000001c8-1471090073.365106-58454676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-13 05:53:51,237 truncating revision to first 12 chars 2016-08-13 05:53:51,237 Setting DEBUG logging. 2016-08-13 05:53:51,237 attempt 1/10 2016-08-13 05:53:51,237 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2ed7e61b988d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-13 05:53:52,555 unpacking tar archive at: mozilla-central-2ed7e61b988d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.662107 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-13 05:53:52.797688) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-13 05:53:52.798038) ========= script_repo_revision: 2ed7e61b988d2466a61528f66050596ef272ebda ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-13 05:53:52.798511) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-13 05:53:52.798812) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-13 05:53:52.809105) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-08-13 05:53:52.809430) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=232498196343f89f466a4a9a000001c8-1471090073.365106-58454676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:53:53 INFO - MultiFileLogger online at 20160813 05:53:53 in /builds/slave/test 05:53:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:53:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:53:53 INFO - {'append_to_log': False, 05:53:53 INFO - 'base_work_dir': '/builds/slave/test', 05:53:53 INFO - 'blob_upload_branch': 'Firefox', 05:53:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:53:53 INFO - 'branch': 'Firefox', 05:53:53 INFO - 'buildbot_json_path': 'buildprops.json', 05:53:53 INFO - 'config_files': ('talos/linux_config.py',), 05:53:53 INFO - 'default_actions': ('clobber', 05:53:53 INFO - 'read-buildbot-config', 05:53:53 INFO - 'download-and-extract', 05:53:53 INFO - 'populate-webroot', 05:53:53 INFO - 'create-virtualenv', 05:53:53 INFO - 'install', 05:53:53 INFO - 'run-tests'), 05:53:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:53:53 INFO - 'download_minidump_stackwalk': True, 05:53:53 INFO - 'download_symbols': 'ondemand', 05:53:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:53:53 INFO - 'tooltool.py': '/tools/tooltool.py', 05:53:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:53:53 INFO - '/tools/misc-python/virtualenv.py')}, 05:53:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:53:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:53:53 INFO - 'installer_path': 'installer.exe', 05:53:53 INFO - 'log_level': 'info', 05:53:53 INFO - 'log_name': 'talos', 05:53:53 INFO - 'log_to_console': True, 05:53:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:53:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:53:53 INFO - 'opt_config_files': (), 05:53:53 INFO - 'pip_index': False, 05:53:53 INFO - 'sps_profile': False, 05:53:53 INFO - 'sps_profile_interval': 0, 05:53:53 INFO - 'suite': 'dromaeojs', 05:53:53 INFO - 'system_bits': '32', 05:53:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:53:53 INFO - 'title': 'talos-linux64-ix-025', 05:53:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:53:53 INFO - 'use_talos_json': True, 05:53:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:53:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:53:53 INFO - 'work_dir': 'build'} 05:53:53 INFO - [mozharness: 2016-08-13 12:53:53.076514Z] Running clobber step. 05:53:53 INFO - Running pre-action listener: _resource_record_pre_action 05:53:53 INFO - Running main action method: clobber 05:53:53 INFO - rmtree: /builds/slave/test/build 05:53:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:53:53 INFO - Running post-action listener: _resource_record_post_action 05:53:53 INFO - [mozharness: 2016-08-13 12:53:53.800305Z] Finished clobber step (success) 05:53:53 INFO - [mozharness: 2016-08-13 12:53:53.800404Z] Running read-buildbot-config step. 05:53:53 INFO - Running pre-action listener: _resource_record_pre_action 05:53:53 INFO - Running main action method: read_buildbot_config 05:53:53 INFO - Using buildbot properties: 05:53:53 INFO - { 05:53:53 INFO - "project": "", 05:53:53 INFO - "product": "firefox", 05:53:53 INFO - "script_repo_revision": "production", 05:53:53 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:53:53 INFO - "repository": "", 05:53:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:53:53 INFO - "buildid": "20160813030202", 05:53:53 INFO - "stage_platform": "linux64-pgo", 05:53:53 INFO - "basedir": "/builds/slave/test", 05:53:53 INFO - "nightly_build": "True", 05:53:53 INFO - "buildnumber": 526, 05:53:53 INFO - "slavename": "talos-linux64-ix-025", 05:53:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:53:53 INFO - "platform": "ubuntu64_hw", 05:53:53 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:53:53 INFO - "branch": "mozilla-central", 05:53:53 INFO - "repo_path": "mozilla-central", 05:53:53 INFO - "revision": "2ed7e61b988d2466a61528f66050596ef272ebda", 05:53:53 INFO - "pgo_build": "True", 05:53:53 INFO - "builduid": "ca9acf50260347be84394eaa8979bdf1", 05:53:53 INFO - "slavebuilddir": "test" 05:53:53 INFO - } 05:53:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/Q-eHDxP1RN---wLJphfvqA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 05:53:53 INFO - Running post-action listener: _resource_record_post_action 05:53:53 INFO - [mozharness: 2016-08-13 12:53:53.802914Z] Finished read-buildbot-config step (success) 05:53:53 INFO - [mozharness: 2016-08-13 12:53:53.803001Z] Running download-and-extract step. 05:53:53 INFO - Running pre-action listener: _resource_record_pre_action 05:53:53 INFO - Running main action method: download_and_extract 05:53:53 INFO - mkdir: /builds/slave/test/build/tests 05:53: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')]} 05:53:53 INFO - trying https://queue.taskcluster.net/v1/task/Q-eHDxP1RN---wLJphfvqA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:53:53 INFO - Downloading https://queue.taskcluster.net/v1/task/Q-eHDxP1RN---wLJphfvqA/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 05:53:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q-eHDxP1RN---wLJphfvqA/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 05:53:54 INFO - Downloaded 1361 bytes. 05:53:54 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:53:54 INFO - Using the following test package requirements: 05:53:54 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:53:54 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:53:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:53:54 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:53:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:53:54 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:53:54 INFO - u'jsshell-linux-x86_64.zip'], 05:53:54 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:53:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:53:54 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:53:54 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:53:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:53:54 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:53:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:53:54 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:53:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:53:54 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:53:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:53:54 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:53:54 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')]} 05:53:54 INFO - trying https://queue.taskcluster.net/v1/task/Q-eHDxP1RN---wLJphfvqA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:53:54 INFO - Downloading https://queue.taskcluster.net/v1/task/Q-eHDxP1RN---wLJphfvqA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:53:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q-eHDxP1RN---wLJphfvqA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:53:55 INFO - Downloaded 21834864 bytes. 05:53:55 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 05:53:59 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 05:53:59 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')]} 05:53:59 INFO - trying https://queue.taskcluster.net/v1/task/Q-eHDxP1RN---wLJphfvqA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:53:59 INFO - Downloading https://queue.taskcluster.net/v1/task/Q-eHDxP1RN---wLJphfvqA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:53:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q-eHDxP1RN---wLJphfvqA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:54:00 INFO - Downloaded 21834864 bytes. 05:54:00 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 05:54: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')]} 05:54:05 INFO - trying https://queue.taskcluster.net/v1/task/Q-eHDxP1RN---wLJphfvqA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:54:05 INFO - Downloading https://queue.taskcluster.net/v1/task/Q-eHDxP1RN---wLJphfvqA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:54:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q-eHDxP1RN---wLJphfvqA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:54:06 INFO - Downloaded 14413719 bytes. 05:54:06 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 05:54:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:06 INFO - trying https://queue.taskcluster.net/v1/task/Q-eHDxP1RN---wLJphfvqA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:54:06 INFO - Downloading https://queue.taskcluster.net/v1/task/Q-eHDxP1RN---wLJphfvqA/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 05:54:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q-eHDxP1RN---wLJphfvqA/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 05:54:08 INFO - Downloaded 59386193 bytes. 05:54:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q-eHDxP1RN---wLJphfvqA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:54:08 INFO - mkdir: /builds/slave/test/properties 05:54:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:54:08 INFO - Writing to file /builds/slave/test/properties/build_url 05:54:08 INFO - Contents: 05:54:08 INFO - build_url:https://queue.taskcluster.net/v1/task/Q-eHDxP1RN---wLJphfvqA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:54:08 INFO - Running post-action listener: _resource_record_post_action 05:54:08 INFO - Running post-action listener: set_extra_try_arguments 05:54:08 INFO - [mozharness: 2016-08-13 12:54:08.695892Z] Finished download-and-extract step (success) 05:54:08 INFO - [mozharness: 2016-08-13 12:54:08.696118Z] Running populate-webroot step. 05:54:08 INFO - Running pre-action listener: _resource_record_pre_action 05:54:08 INFO - Running main action method: populate_webroot 05:54:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:54:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:54:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:54:08 INFO - '--tppagecycles', 05:54:08 INFO - '7'], 05:54:08 INFO - 'tests': ['tsvgm']}}, 05:54:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:54:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:54:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:54:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:54:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:54:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:54:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:08 INFO - 'talos_options': ['--disable-e10s'], 05:54:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:54:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:54:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:08 INFO - 'talos_options': ['--disable-e10s'], 05:54:08 INFO - 'tests': ['damp', 'tps']}, 05:54:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:08 INFO - 'tests': ['damp', 'tps']}, 05:54:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:54:08 INFO - 'tests': ['dromaeo_dom']}, 05:54:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:54:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:54:08 INFO - 'tests': ['basic_compositor_video']}, 05:54:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:54:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:54:08 INFO - 'tests': ['a11yr', 05:54:08 INFO - 'ts_paint', 05:54:08 INFO - 'tpaint', 05:54:08 INFO - 'sessionrestore', 05:54:08 INFO - 'sessionrestore_no_auto_restore', 05:54:08 INFO - 'tabpaint']}, 05:54:08 INFO - 'other-e10s': {'tests': ['a11yr', 05:54:08 INFO - 'ts_paint', 05:54:08 INFO - 'tpaint', 05:54:08 INFO - 'sessionrestore', 05:54:08 INFO - 'sessionrestore_no_auto_restore', 05:54:08 INFO - 'tabpaint']}, 05:54:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:54:08 INFO - 'ts_paint', 05:54:08 INFO - 'tpaint', 05:54:08 INFO - 'sessionrestore', 05:54:08 INFO - 'sessionrestore_no_auto_restore', 05:54:08 INFO - 'tabpaint']}, 05:54:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:54:08 INFO - 'ts_paint', 05:54:08 INFO - 'tpaint', 05:54:08 INFO - 'sessionrestore', 05:54:08 INFO - 'sessionrestore_no_auto_restore', 05:54:08 INFO - 'tabpaint']}, 05:54:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:54:08 INFO - 'tests': ['a11yr', 05:54:08 INFO - 'ts_paint', 05:54:08 INFO - 'tpaint', 05:54:08 INFO - 'sessionrestore', 05:54:08 INFO - 'sessionrestore_no_auto_restore', 05:54:08 INFO - 'tabpaint']}, 05:54:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:54:08 INFO - 'tests': ['a11yr', 05:54:08 INFO - 'ts_paint', 05:54:08 INFO - 'tpaint', 05:54:08 INFO - 'sessionrestore', 05:54:08 INFO - 'sessionrestore_no_auto_restore', 05:54:08 INFO - 'tabpaint']}, 05:54:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:54:08 INFO - 'tests': ['tsvgx', 05:54:08 INFO - 'tsvgr_opacity', 05:54:08 INFO - 'tart', 05:54:08 INFO - 'tscrollx', 05:54:08 INFO - 'cart']}, 05:54:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:54:08 INFO - 'tsvgr_opacity', 05:54:08 INFO - 'tart', 05:54:08 INFO - 'tscrollx', 05:54:08 INFO - 'cart']}, 05:54:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:08 INFO - 'talos_options': ['--disable-e10s'], 05:54:08 INFO - 'tests': ['tp5o']}, 05:54:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:08 INFO - 'tests': ['tp5o']}, 05:54:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:08 INFO - 'talos_options': ['--disable-e10s', 05:54:08 INFO - '--xperf_path', 05:54:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:54:08 INFO - 'tests': ['tp5n']}, 05:54:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:08 INFO - 'talos_options': ['--xperf_path', 05:54:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:54:08 INFO - 'tests': ['tp5n']}}, 05:54:08 INFO - 'talos.zip': {'path': '', 05:54:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:54:08 INFO - Running post-action listener: _resource_record_post_action 05:54:08 INFO - [mozharness: 2016-08-13 12:54:08.718021Z] Finished populate-webroot step (success) 05:54:08 INFO - [mozharness: 2016-08-13 12:54:08.718110Z] Running create-virtualenv step. 05:54:08 INFO - Running pre-action listener: _resource_record_pre_action 05:54:08 INFO - Running main action method: create_virtualenv 05:54:08 INFO - Creating virtualenv /builds/slave/test/build/venv 05:54:08 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 05:54:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:54:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:54:08 INFO - Using real prefix '/usr' 05:54:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:54:09 INFO - Installing distribute.............................................................................................................................................................................................done. 05:54:11 INFO - Installing pip.................done. 05:54:11 INFO - Return code: 0 05:54:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:54:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:11 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 0x7fafcebf8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249d370>, '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 0x24a08f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a0d80>, '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': '232498196343f89f466a4a9a000001c8-1471090073.365106-58454676', '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 05:54:11 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 05:54:11 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 05:54:11 INFO - Using env: {'DISPLAY': ':0', 05:54:11 INFO - 'HOME': '/home/cltbld', 05:54:11 INFO - 'LANG': 'en_US.UTF-8', 05:54:11 INFO - 'LANGUAGE': 'en_US:en', 05:54:11 INFO - 'LOGNAME': 'cltbld', 05:54:11 INFO - 'MAIL': '/var/mail/cltbld', 05:54:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:11 INFO - 'MOZ_NO_REMOTE': '1', 05:54:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:11 INFO - 'NO_EM_RESTART': '1', 05:54:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:11 INFO - 'PWD': '/builds/slave/test', 05:54:11 INFO - 'SHELL': '/bin/bash', 05:54:11 INFO - 'SHLVL': '1', 05:54:11 INFO - 'TERM': 'linux', 05:54:11 INFO - 'TMOUT': '86400', 05:54:11 INFO - 'USER': 'cltbld', 05:54:11 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471090073.365106-58454676', 05:54:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:11 INFO - '_': '/tools/buildbot/bin/python'} 05:54:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:12 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 05:54:12 INFO - Cleaning up... 05:54:12 INFO - Return code: 0 05:54:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:54:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fafcebf8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249d370>, '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 0x24a08f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a0d80>, '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': '232498196343f89f466a4a9a000001c8-1471090073.365106-58454676', '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 05:54:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:54:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:54:12 INFO - Using env: {'DISPLAY': ':0', 05:54:12 INFO - 'HOME': '/home/cltbld', 05:54:12 INFO - 'LANG': 'en_US.UTF-8', 05:54:12 INFO - 'LANGUAGE': 'en_US:en', 05:54:12 INFO - 'LOGNAME': 'cltbld', 05:54:12 INFO - 'MAIL': '/var/mail/cltbld', 05:54:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:12 INFO - 'MOZ_NO_REMOTE': '1', 05:54:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:12 INFO - 'NO_EM_RESTART': '1', 05:54:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:12 INFO - 'PWD': '/builds/slave/test', 05:54:12 INFO - 'SHELL': '/bin/bash', 05:54:12 INFO - 'SHLVL': '1', 05:54:12 INFO - 'TERM': 'linux', 05:54:12 INFO - 'TMOUT': '86400', 05:54:12 INFO - 'USER': 'cltbld', 05:54:12 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471090073.365106-58454676', 05:54:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:12 INFO - '_': '/tools/buildbot/bin/python'} 05:54:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:12 INFO - Downloading/unpacking psutil>=3.1.1 05:54:12 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 05:54:12 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 05:54:12 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 05:54:12 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 05:54:12 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 05:54:12 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 05:54:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:54:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:54:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:54:14 INFO - Installing collected packages: psutil 05:54:14 INFO - Running setup.py install for psutil 05:54:14 INFO - building 'psutil._psutil_linux' extension 05:54:14 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 05:54:15 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 05:54:15 INFO - building 'psutil._psutil_posix' extension 05:54:15 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 05:54:15 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 05:54:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:54:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:54:15 INFO - Successfully installed psutil 05:54:15 INFO - Cleaning up... 05:54:16 INFO - Return code: 0 05:54:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:54:16 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')]} 05:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:16 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')]} 05:54:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:16 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 0x7fafcebf8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249d370>, '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 0x24a08f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a0d80>, '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': '232498196343f89f466a4a9a000001c8-1471090073.365106-58454676', '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 05:54:16 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 05:54:16 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 05:54:16 INFO - Using env: {'DISPLAY': ':0', 05:54:16 INFO - 'HOME': '/home/cltbld', 05:54:16 INFO - 'LANG': 'en_US.UTF-8', 05:54:16 INFO - 'LANGUAGE': 'en_US:en', 05:54:16 INFO - 'LOGNAME': 'cltbld', 05:54:16 INFO - 'MAIL': '/var/mail/cltbld', 05:54:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:16 INFO - 'MOZ_NO_REMOTE': '1', 05:54:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:16 INFO - 'NO_EM_RESTART': '1', 05:54:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:16 INFO - 'PWD': '/builds/slave/test', 05:54:16 INFO - 'SHELL': '/bin/bash', 05:54:16 INFO - 'SHLVL': '1', 05:54:16 INFO - 'TERM': 'linux', 05:54:16 INFO - 'TMOUT': '86400', 05:54:16 INFO - 'USER': 'cltbld', 05:54:16 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471090073.365106-58454676', 05:54:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:16 INFO - '_': '/tools/buildbot/bin/python'} 05:54:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:54:16 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 05:54:16 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 05:54:16 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 05:54:16 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 05:54:16 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 05:54:16 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 05:54:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:54:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:54:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:54:18 INFO - Installing collected packages: mozsystemmonitor 05:54:18 INFO - Running setup.py install for mozsystemmonitor 05:54:18 INFO - Successfully installed mozsystemmonitor 05:54:18 INFO - Cleaning up... 05:54:18 INFO - Return code: 0 05:54:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:54:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:18 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 0x7fafcebf8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249d370>, '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 0x24a08f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a0d80>, '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': '232498196343f89f466a4a9a000001c8-1471090073.365106-58454676', '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 05:54:18 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 05:54:18 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 05:54:18 INFO - Using env: {'DISPLAY': ':0', 05:54:18 INFO - 'HOME': '/home/cltbld', 05:54:18 INFO - 'LANG': 'en_US.UTF-8', 05:54:18 INFO - 'LANGUAGE': 'en_US:en', 05:54:18 INFO - 'LOGNAME': 'cltbld', 05:54:18 INFO - 'MAIL': '/var/mail/cltbld', 05:54:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:18 INFO - 'MOZ_NO_REMOTE': '1', 05:54:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:18 INFO - 'NO_EM_RESTART': '1', 05:54:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:18 INFO - 'PWD': '/builds/slave/test', 05:54:18 INFO - 'SHELL': '/bin/bash', 05:54:18 INFO - 'SHLVL': '1', 05:54:18 INFO - 'TERM': 'linux', 05:54:18 INFO - 'TMOUT': '86400', 05:54:18 INFO - 'USER': 'cltbld', 05:54:18 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471090073.365106-58454676', 05:54:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:18 INFO - '_': '/tools/buildbot/bin/python'} 05:54:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:18 INFO - Downloading/unpacking jsonschema==2.5.1 05:54:18 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 05:54:18 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 05:54:18 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 05:54:18 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 05:54:18 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 05:54:18 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 05:54:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:54:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:54:20 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 05:54:20 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 05:54:20 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 05:54:20 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 05:54:20 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 05:54:20 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 05:54:20 INFO - Downloading functools32-3.2.3-2.tar.gz 05:54:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:54:20 INFO - warning: no files found matching '*.txt' 05:54:20 INFO - no previously-included directories found matching 'build' 05:54:20 INFO - no previously-included directories found matching 'dist' 05:54:20 INFO - no previously-included directories found matching '.git*' 05:54:20 INFO - Installing collected packages: jsonschema, functools32 05:54:20 INFO - Running setup.py install for functools32 05:54:20 INFO - warning: no files found matching '*.txt' 05:54:20 INFO - no previously-included directories found matching 'build' 05:54:20 INFO - no previously-included directories found matching 'dist' 05:54:20 INFO - no previously-included directories found matching '.git*' 05:54:20 INFO - Successfully installed jsonschema functools32 05:54:20 INFO - Cleaning up... 05:54:20 INFO - Return code: 0 05:54:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:54:20 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')]} 05:54:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:20 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')]} 05:54:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:20 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 0x7fafcebf8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249d370>, '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 0x24a08f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a0d80>, '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': '232498196343f89f466a4a9a000001c8-1471090073.365106-58454676', '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 05:54:20 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 05:54:20 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 05:54:20 INFO - Using env: {'DISPLAY': ':0', 05:54:20 INFO - 'HOME': '/home/cltbld', 05:54:20 INFO - 'LANG': 'en_US.UTF-8', 05:54:20 INFO - 'LANGUAGE': 'en_US:en', 05:54:20 INFO - 'LOGNAME': 'cltbld', 05:54:20 INFO - 'MAIL': '/var/mail/cltbld', 05:54:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:20 INFO - 'MOZ_NO_REMOTE': '1', 05:54:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:20 INFO - 'NO_EM_RESTART': '1', 05:54:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:20 INFO - 'PWD': '/builds/slave/test', 05:54:20 INFO - 'SHELL': '/bin/bash', 05:54:20 INFO - 'SHLVL': '1', 05:54:20 INFO - 'TERM': 'linux', 05:54:20 INFO - 'TMOUT': '86400', 05:54:20 INFO - 'USER': 'cltbld', 05:54:20 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471090073.365106-58454676', 05:54:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:20 INFO - '_': '/tools/buildbot/bin/python'} 05:54:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:54:21 INFO - Cleaning up... 05:54:21 INFO - Return code: 0 05:54:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:54:21 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')]} 05:54:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:21 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')]} 05:54:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:21 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 0x7fafcebf8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249d370>, '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 0x24a08f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a0d80>, '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': '232498196343f89f466a4a9a000001c8-1471090073.365106-58454676', '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 05:54:21 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 05:54:21 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 05:54:21 INFO - Using env: {'DISPLAY': ':0', 05:54:21 INFO - 'HOME': '/home/cltbld', 05:54:21 INFO - 'LANG': 'en_US.UTF-8', 05:54:21 INFO - 'LANGUAGE': 'en_US:en', 05:54:21 INFO - 'LOGNAME': 'cltbld', 05:54:21 INFO - 'MAIL': '/var/mail/cltbld', 05:54:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:21 INFO - 'MOZ_NO_REMOTE': '1', 05:54:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:21 INFO - 'NO_EM_RESTART': '1', 05:54:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:21 INFO - 'PWD': '/builds/slave/test', 05:54:21 INFO - 'SHELL': '/bin/bash', 05:54:21 INFO - 'SHLVL': '1', 05:54:21 INFO - 'TERM': 'linux', 05:54:21 INFO - 'TMOUT': '86400', 05:54:21 INFO - 'USER': 'cltbld', 05:54:21 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471090073.365106-58454676', 05:54:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:21 INFO - '_': '/tools/buildbot/bin/python'} 05:54:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:21 INFO - Downloading/unpacking blobuploader==1.2.4 05:54:21 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 05:54:21 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 05:54:21 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 05:54:21 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 05:54:21 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 05:54:21 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 05:54:23 INFO - Downloading blobuploader-1.2.4.tar.gz 05:54:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:54:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:54:23 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 05:54:23 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 05:54:23 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 05:54:23 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 05:54:23 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 05:54:23 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 05:54:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:54:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:54:23 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 05:54:23 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 05:54:23 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 05:54:23 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 05:54:23 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 05:54:23 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 05:54:23 INFO - Downloading docopt-0.6.1.tar.gz 05:54:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:54:23 INFO - Installing collected packages: blobuploader, requests, docopt 05:54:23 INFO - Running setup.py install for blobuploader 05:54:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:54:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:54:24 INFO - Running setup.py install for requests 05:54:24 INFO - Running setup.py install for docopt 05:54:24 INFO - Successfully installed blobuploader requests docopt 05:54:24 INFO - Cleaning up... 05:54:24 INFO - Return code: 0 05:54:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:54:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:24 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 0x7fafcebf8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249d370>, '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 0x24a08f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a0d80>, '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': '232498196343f89f466a4a9a000001c8-1471090073.365106-58454676', '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 05:54:24 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 05:54:24 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 05:54:24 INFO - Using env: {'DISPLAY': ':0', 05:54:24 INFO - 'HOME': '/home/cltbld', 05:54:24 INFO - 'LANG': 'en_US.UTF-8', 05:54:24 INFO - 'LANGUAGE': 'en_US:en', 05:54:24 INFO - 'LOGNAME': 'cltbld', 05:54:24 INFO - 'MAIL': '/var/mail/cltbld', 05:54:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:24 INFO - 'MOZ_NO_REMOTE': '1', 05:54:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:24 INFO - 'NO_EM_RESTART': '1', 05:54:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:24 INFO - 'PWD': '/builds/slave/test', 05:54:24 INFO - 'SHELL': '/bin/bash', 05:54:24 INFO - 'SHLVL': '1', 05:54:24 INFO - 'TERM': 'linux', 05:54:24 INFO - 'TMOUT': '86400', 05:54:24 INFO - 'USER': 'cltbld', 05:54:24 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471090073.365106-58454676', 05:54:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:24 INFO - '_': '/tools/buildbot/bin/python'} 05:54:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:54:24 INFO - Running setup.py (path:/tmp/pip-fJObQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:54:24 INFO - Running setup.py (path:/tmp/pip-gWjv9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:54:24 INFO - Running setup.py (path:/tmp/pip-gN4EYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:54:25 INFO - Running setup.py (path:/tmp/pip-RFKFFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:54:25 INFO - Running setup.py (path:/tmp/pip-EbtYkO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:54:25 INFO - Running setup.py (path:/tmp/pip-ziviYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:54:25 INFO - Running setup.py (path:/tmp/pip-dqSUyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:54:25 INFO - Running setup.py (path:/tmp/pip-q3coa_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:54:25 INFO - Running setup.py (path:/tmp/pip-AJ7F76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:54:25 INFO - Running setup.py (path:/tmp/pip-cczw3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:54:25 INFO - Running setup.py (path:/tmp/pip-99bw7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:54:25 INFO - Running setup.py (path:/tmp/pip-CdsSKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:54:25 INFO - Running setup.py (path:/tmp/pip-pIHSeh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:54:25 INFO - Running setup.py (path:/tmp/pip-ytbPcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:25 INFO - Running setup.py (path:/tmp/pip-B7MTxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:54:25 INFO - Running setup.py (path:/tmp/pip-scMHfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:54:25 INFO - Running setup.py (path:/tmp/pip-uT0VcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:54:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:54:26 INFO - Running setup.py install for manifestparser 05:54:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:54:26 INFO - Running setup.py install for mozcrash 05:54:26 INFO - Running setup.py install for mozdebug 05:54:26 INFO - Running setup.py install for mozdevice 05:54:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:54:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:54:26 INFO - Running setup.py install for mozfile 05:54:26 INFO - Running setup.py install for mozhttpd 05:54:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:54:26 INFO - Running setup.py install for mozinfo 05:54:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:54:26 INFO - Running setup.py install for mozInstall 05:54:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:54:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:54:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:54:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:54:26 INFO - Running setup.py install for mozleak 05:54:26 INFO - Running setup.py install for mozlog 05:54:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:54:27 INFO - Running setup.py install for moznetwork 05:54:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:54:27 INFO - Running setup.py install for mozprocess 05:54:27 INFO - Running setup.py install for mozprofile 05:54:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:54:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:54:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:54:27 INFO - Running setup.py install for mozrunner 05:54:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:54:27 INFO - Running setup.py install for mozscreenshot 05:54:27 INFO - Running setup.py install for moztest 05:54:27 INFO - Running setup.py install for mozversion 05:54:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:54:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:54:27 INFO - Cleaning up... 05:54:27 INFO - Return code: 0 05:54:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:54:27 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')]} 05:54:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:27 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')]} 05:54:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:27 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 0x7fafcebf8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249d370>, '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 0x24a08f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a0d80>, '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': '232498196343f89f466a4a9a000001c8-1471090073.365106-58454676', '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 05:54:27 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 05:54:27 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 05:54:27 INFO - Using env: {'DISPLAY': ':0', 05:54:27 INFO - 'HOME': '/home/cltbld', 05:54:27 INFO - 'LANG': 'en_US.UTF-8', 05:54:27 INFO - 'LANGUAGE': 'en_US:en', 05:54:27 INFO - 'LOGNAME': 'cltbld', 05:54:27 INFO - 'MAIL': '/var/mail/cltbld', 05:54:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:27 INFO - 'MOZ_NO_REMOTE': '1', 05:54:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:27 INFO - 'NO_EM_RESTART': '1', 05:54:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:27 INFO - 'PWD': '/builds/slave/test', 05:54:27 INFO - 'SHELL': '/bin/bash', 05:54:27 INFO - 'SHLVL': '1', 05:54:27 INFO - 'TERM': 'linux', 05:54:27 INFO - 'TMOUT': '86400', 05:54:27 INFO - 'USER': 'cltbld', 05:54:27 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471090073.365106-58454676', 05:54:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:27 INFO - '_': '/tools/buildbot/bin/python'} 05:54:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:54:28 INFO - Running setup.py (path:/tmp/pip-CbtcdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:54:28 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)) 05:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:54:28 INFO - Running setup.py (path:/tmp/pip-pJvJG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:54:28 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)) 05:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:54:28 INFO - Running setup.py (path:/tmp/pip-QGFkml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:54:28 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)) 05:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:54:28 INFO - Running setup.py (path:/tmp/pip-H3kXXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:54:28 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)) 05:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:54:28 INFO - Running setup.py (path:/tmp/pip-0pIHwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:54:28 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)) 05:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:54:28 INFO - Running setup.py (path:/tmp/pip-0GIJyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:54:28 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)) 05:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:54:28 INFO - Running setup.py (path:/tmp/pip-RdLEAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:54:28 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)) 05:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:54:28 INFO - Running setup.py (path:/tmp/pip-T8wmE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:54:28 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)) 05:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:54:28 INFO - Running setup.py (path:/tmp/pip-8KAgLh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:54:28 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)) 05:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:54:28 INFO - Running setup.py (path:/tmp/pip-oet7UR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:54:28 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)) 05:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:54:28 INFO - Running setup.py (path:/tmp/pip-74ErzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:54:28 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)) 05:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:54:28 INFO - Running setup.py (path:/tmp/pip-Pc9LDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:54:28 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)) 05:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:54:28 INFO - Running setup.py (path:/tmp/pip-cAgIBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:54:28 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)) 05:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:54:28 INFO - Running setup.py (path:/tmp/pip-HEPO4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:54:29 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)) 05:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:29 INFO - Running setup.py (path:/tmp/pip-QXSasB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:29 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)) 05:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:54:29 INFO - Running setup.py (path:/tmp/pip-xJotQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:54:29 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)) 05:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:54:29 INFO - Running setup.py (path:/tmp/pip-G4ww4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:54:29 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)) 05:54:29 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)) 05:54:29 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)) 05:54:29 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)) 05:54:29 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)) 05:54:29 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)) 05:54:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:54:29 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 05:54:29 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 05:54:29 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 05:54:29 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 05:54:29 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 05:54:29 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 05:54:31 INFO - Downloading blessings-1.6.tar.gz 05:54:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:54:31 INFO - Installing collected packages: blessings 05:54:31 INFO - Running setup.py install for blessings 05:54:31 INFO - Successfully installed blessings 05:54:31 INFO - Cleaning up... 05:54:31 INFO - Return code: 0 05:54:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:54:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:54:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:54:31 INFO - Reading from file tmpfile_stdout 05:54:31 INFO - Current package versions: 05:54:31 INFO - argparse == 1.2.1 05:54:31 INFO - blessings == 1.6 05:54:31 INFO - blobuploader == 1.2.4 05:54:31 INFO - docopt == 0.6.1 05:54:31 INFO - functools32 == 3.2.3-2 05:54:31 INFO - jsonschema == 2.5.1 05:54:31 INFO - manifestparser == 1.1 05:54:31 INFO - mozInstall == 1.12 05:54:31 INFO - mozcrash == 0.17 05:54:31 INFO - mozdebug == 0.1 05:54:31 INFO - mozdevice == 0.48 05:54:31 INFO - mozfile == 1.2 05:54:31 INFO - mozhttpd == 0.7 05:54:31 INFO - mozinfo == 0.9 05:54:31 INFO - mozleak == 0.1 05:54:31 INFO - mozlog == 3.3 05:54:31 INFO - moznetwork == 0.27 05:54:31 INFO - mozprocess == 0.23 05:54:31 INFO - mozprofile == 0.28 05:54:31 INFO - mozrunner == 6.12 05:54:31 INFO - mozscreenshot == 0.1 05:54:31 INFO - mozsystemmonitor == 0.3 05:54:31 INFO - moztest == 0.7 05:54:31 INFO - mozversion == 1.4 05:54:31 INFO - psutil == 3.1.1 05:54:31 INFO - requests == 1.2.3 05:54:31 INFO - wsgiref == 0.1.2 05:54:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:54:31 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')]} 05:54:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:31 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')]} 05:54:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:31 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 0x7fafcebf8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249d370>, '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 0x24a08f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a0d80>, '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': '232498196343f89f466a4a9a000001c8-1471090073.365106-58454676', '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 05:54:31 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 05:54:31 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 05:54:31 INFO - Using env: {'DISPLAY': ':0', 05:54:31 INFO - 'HOME': '/home/cltbld', 05:54:31 INFO - 'LANG': 'en_US.UTF-8', 05:54:31 INFO - 'LANGUAGE': 'en_US:en', 05:54:31 INFO - 'LOGNAME': 'cltbld', 05:54:31 INFO - 'MAIL': '/var/mail/cltbld', 05:54:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:31 INFO - 'MOZ_NO_REMOTE': '1', 05:54:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:31 INFO - 'NO_EM_RESTART': '1', 05:54:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:31 INFO - 'PWD': '/builds/slave/test', 05:54:31 INFO - 'SHELL': '/bin/bash', 05:54:31 INFO - 'SHLVL': '1', 05:54:31 INFO - 'TERM': 'linux', 05:54:31 INFO - 'TMOUT': '86400', 05:54:31 INFO - 'USER': 'cltbld', 05:54:31 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471090073.365106-58454676', 05:54:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:31 INFO - '_': '/tools/buildbot/bin/python'} 05:54:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:31 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)) 05:54:31 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)) 05:54:31 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)) 05:54:31 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)) 05:54:31 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)) 05:54:31 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)) 05:54:31 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)) 05:54:31 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)) 05:54:31 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)) 05:54:31 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)) 05:54:31 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)) 05:54:31 INFO - Cleaning up... 05:54:31 INFO - Return code: 0 05:54:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:54:31 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')]} 05:54:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:31 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')]} 05:54:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:31 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 0x7fafcebf8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249d370>, '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 0x24a08f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a0d80>, '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': '232498196343f89f466a4a9a000001c8-1471090073.365106-58454676', '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 05:54:31 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 05:54:31 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 05:54:31 INFO - Using env: {'DISPLAY': ':0', 05:54:31 INFO - 'HOME': '/home/cltbld', 05:54:31 INFO - 'LANG': 'en_US.UTF-8', 05:54:31 INFO - 'LANGUAGE': 'en_US:en', 05:54:31 INFO - 'LOGNAME': 'cltbld', 05:54:31 INFO - 'MAIL': '/var/mail/cltbld', 05:54:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:31 INFO - 'MOZ_NO_REMOTE': '1', 05:54:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:31 INFO - 'NO_EM_RESTART': '1', 05:54:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:31 INFO - 'PWD': '/builds/slave/test', 05:54:31 INFO - 'SHELL': '/bin/bash', 05:54:31 INFO - 'SHLVL': '1', 05:54:31 INFO - 'TERM': 'linux', 05:54:31 INFO - 'TMOUT': '86400', 05:54:31 INFO - 'USER': 'cltbld', 05:54:31 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471090073.365106-58454676', 05:54:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:31 INFO - '_': '/tools/buildbot/bin/python'} 05:54:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:54:32 INFO - Cleaning up... 05:54:32 INFO - Return code: 0 05:54:32 INFO - Running post-action listener: _resource_record_post_action 05:54:32 INFO - Running post-action listener: _start_resource_monitoring 05:54:32 INFO - Starting resource monitoring. 05:54:32 INFO - [mozharness: 2016-08-13 12:54:32.139191Z] Finished create-virtualenv step (success) 05:54:32 INFO - [mozharness: 2016-08-13 12:54:32.140195Z] Running install step. 05:54:32 INFO - Running pre-action listener: _resource_record_pre_action 05:54:32 INFO - Running main action method: install 05:54:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:54:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:54:32 INFO - Reading from file tmpfile_stdout 05:54:32 INFO - Detecting whether we're running mozinstall >=1.0... 05:54:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:54:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:54:32 INFO - Reading from file tmpfile_stdout 05:54:32 INFO - Output received: 05:54:32 INFO - Usage: mozinstall [options] installer 05:54:32 INFO - Options: 05:54:32 INFO - -h, --help show this help message and exit 05:54:32 INFO - -d DEST, --destination=DEST 05:54:32 INFO - Directory to install application into. [default: 05:54:32 INFO - "/builds/slave/test"] 05:54:32 INFO - --app=APP Application being installed. [default: firefox] 05:54:32 INFO - mkdir: /builds/slave/test/build/application 05:54:32 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'] 05:54:32 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 05:54:49 INFO - Reading from file tmpfile_stdout 05:54:49 INFO - Output received: 05:54:49 INFO - /builds/slave/test/build/application/firefox/firefox 05:54:49 INFO - Running post-action listener: _resource_record_post_action 05:54:49 INFO - [mozharness: 2016-08-13 12:54:49.315231Z] Finished install step (success) 05:54:49 INFO - [mozharness: 2016-08-13 12:54:49.315477Z] Running run-tests step. 05:54:49 INFO - Running pre-action listener: _resource_record_pre_action 05:54:49 INFO - Running main action method: run_tests 05:54:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:54:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:54:49 INFO - Python 2.7.3 05:54:49 INFO - Return code: 0 05:54:49 INFO - grabbing minidump binary from tooltool 05:54:49 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')]} 05:54:49 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 0x249d370>, '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 0x24a08f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a0d80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:54:49 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 05:54:49 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 05:54:49 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 05:54:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:54:49 INFO - Return code: 0 05:54:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:54:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:54:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:54:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:54:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:54:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q-eHDxP1RN---wLJphfvqA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 05:54:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Q-eHDxP1RN---wLJphfvqA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --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 05:54:49 INFO - Using env: {'DISPLAY': ':0', 05:54:49 INFO - 'HOME': '/home/cltbld', 05:54:49 INFO - 'LANG': 'en_US.UTF-8', 05:54:49 INFO - 'LANGUAGE': 'en_US:en', 05:54:49 INFO - 'LOGNAME': 'cltbld', 05:54:49 INFO - 'MAIL': '/var/mail/cltbld', 05:54:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:54:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:54:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:49 INFO - 'MOZ_NO_REMOTE': '1', 05:54:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:54:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:49 INFO - 'NO_EM_RESTART': '1', 05:54:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:49 INFO - 'PWD': '/builds/slave/test', 05:54:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:54:49 INFO - 'SHELL': '/bin/bash', 05:54:49 INFO - 'SHLVL': '1', 05:54:49 INFO - 'TERM': 'linux', 05:54:49 INFO - 'TMOUT': '86400', 05:54:49 INFO - 'USER': 'cltbld', 05:54:49 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1471090073.365106-58454676', 05:54:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:49 INFO - '_': '/tools/buildbot/bin/python'} 05:54:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q-eHDxP1RN---wLJphfvqA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 05:54:49 INFO - mozversion application_buildid: 20160813030202 05:54:49 INFO - mozversion application_changeset: 2ed7e61b988d2466a61528f66050596ef272ebda 05:54:49 INFO - mozversion application_display_name: Nightly 05:54:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:54:49 INFO - mozversion application_name: Firefox 05:54:49 INFO - mozversion application_remotingname: firefox 05:54:49 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:54:49 INFO - mozversion application_vendor: Mozilla 05:54:49 INFO - mozversion application_version: 51.0a1 05:54:49 INFO - mozversion platform_buildid: 20160813030202 05:54:49 INFO - mozversion platform_changeset: 2ed7e61b988d2466a61528f66050596ef272ebda 05:54:49 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:54:49 INFO - mozversion platform_version: 51.0a1 05:54:49 INFO - using testdate: 1471092889 05:54:49 INFO - actual date: 1471092889 05:54:49 INFO - starting webserver on 'localhost:56509' 05:54:49 INFO - SUITE-START | Running 2 tests 05:54:49 INFO - TEST-START | dromaeo_css 05:54:49 INFO - operating with platform_type : linux_ 05:54:49 INFO - Initialising browser for dromaeo_css test... 05:54:49 INFO - TEST-INFO | started process 3380 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGnSjqb/profile http://localhost:56509/getInfo.html) 05:54:54 INFO - PROCESS | 3380 | __metrics Screen width/height:1600/1200 05:54:54 INFO - PROCESS | 3380 | colorDepth:24 05:54:54 INFO - PROCESS | 3380 | Browser inner width/height: 1024/697 05:54:54 INFO - PROCESS | 3380 | __metrics 05:54:55 INFO - PROCESS | 3380 | 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" 05:54:55 INFO - PROCESS | 3380 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:54:56 INFO - TEST-INFO | 3380: exit 0 05:54:56 INFO - Browser initialized. 05:54:56 INFO - Running cycle 1/1 for dromaeo_css test... 05:54:56 INFO - TEST-INFO | started process 3462 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGnSjqb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:55:08 INFO - PROCESS | 3462 | RSS: Main: 155910144 05:55:08 INFO - PROCESS | 3462 | 05:55:59 INFO - PROCESS | 3462 | 1471092959936 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] 05:58:09 INFO - PROCESS | 3462 | Cycle 1(1): loaded http://localhost:56509/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56509/tests/dromaeo/cssquery-ext.html) 05:58:10 INFO - PROCESS | 3462 | RSS: Main: 250757120 05:58:10 INFO - PROCESS | 3462 | 06:01:13 INFO - PROCESS | 3462 | Cycle 1(1): loaded http://localhost:56509/tests/dromaeo/cssquery-ext.html (next: http://localhost:56509/tests/dromaeo/cssquery-jquery.html) 06:01:13 INFO - PROCESS | 3462 | RSS: Main: 245538816 06:01:13 INFO - PROCESS | 3462 | 06:04:15 INFO - PROCESS | 3462 | Cycle 1(1): loaded http://localhost:56509/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56509/tests/dromaeo/cssquery-mootools.html) 06:04:16 INFO - PROCESS | 3462 | RSS: Main: 185810944 06:04:16 INFO - PROCESS | 3462 | 06:07:18 INFO - PROCESS | 3462 | Cycle 1(1): loaded http://localhost:56509/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56509/tests/dromaeo/cssquery-prototype.html) 06:07:19 INFO - PROCESS | 3462 | RSS: Main: 183709696 06:07:19 INFO - PROCESS | 3462 | 06:10:21 INFO - PROCESS | 3462 | Cycle 1(1): loaded http://localhost:56509/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56509/tests/dromaeo/cssquery-yui.html) 06:10:22 INFO - PROCESS | 3462 | RSS: Main: 184680448 06:10:22 INFO - PROCESS | 3462 | 06:13:25 INFO - PROCESS | 3462 | Cycle 1(1): loaded http://localhost:56509/tests/dromaeo/cssquery-yui.html (next: http://localhost:56509/tests/dromaeo/cssquery-dojo.html) 06:13:25 INFO - PROCESS | 3462 | RSS: Main: 276701184 06:13:25 INFO - PROCESS | 3462 | 06:13:25 INFO - PROCESS | 3462 | __start_tp_report 06:13:25 INFO - PROCESS | 3462 | _x_x_mozilla_page_load 06:13:25 INFO - PROCESS | 3462 | _x_x_mozilla_page_load_details 06:13:25 INFO - PROCESS | 3462 | |i|pagename|runs| 06:13:25 INFO - PROCESS | 3462 | |0;dojo.html;3042.330687248805;3069.677683843197;3070.8464576771185;3082.876684932603;3088.7992280501767;5256.080185967459;5303.151495760679;5349.5720342372615;5387.91918121228;5432.999999999995;5364.5708343332535;5407.215953686713;5425.7287135643255;5462.20797984293;5528.336599608053;4882.633802464811;4910.75446227689;4982.9252561211615;4986.87532811679;5073.112205364065;4989.426215985171;5013.197888337867;5034.697918124906;5048.873778155539;5049.444561098277;4768.260919557457;4874.902501949977;4896.730679812609;4930.087933732253;4932.482089380599;4869.756512174413;4879.024195160947;4883.12103821312;4951.628627852925;4988.551030407244;4905;4936.33359496467;4937.851864444073;4947.282644016634;4986.2769898364895;5297.47025297471;5377.489138531833;5450.5367043800925;5459.69971651559;5514.503694667499;5902.468777810018;5922.170896074553;5924.644521328734;5933.465988061095;5937.67342796146;5624.71876406178;5889.322727886305;5910.822675319747;5920.2007728956905;5968.880622387528;5368;5423.457654234624;5426;5526.309211348582;5526.668399896019;6052.455279024909;6058.727357268934;6060;6060.545459090586;6063.454289114001;5529.364123125812;5749.367569567345;5787;5793.826185214451;5798.362180160179;5752.884942301214;5768.105943578752;5802.506786923159;5877.089051197071;5887.293524776968;5757.9424205757405;5810.360860305363;5812.912806307909;5816.331121921034;5863.648181109062;5768.625039372428;5827.417258274223;5832.12518122285;5838.7080645967535;5867.882642347129;4338.783060846945;4358.6730995175485;4366.519682834885;4444.73331600105;4449.510553839075;3922.5292964844402;3947.7236593438183;3968.305546529346;4047.1096358801606;4071.714979951434;5503.779848806083;5505.614606977473;5510.173473978855;5512.614117011771;5553.250311208016;5895.911561326584;5896.941030589639;5899.174115623816;5901.5868889177345;5910.290765108214;5245.186996015624;5374.4625537445945;5416.620836541483;5417.83746487606;5505.559555235572;4860.80556777732;4894.583960363409;4899.2896030075435;4900.411950565955;4932.038252540792;5981.401859813984;5982.970085149546;5987.042073268256;5993.0710739835395;6009.1587177795145;5638.5771067170945;5776.19133321327;5840.065589505659;5850.356460789395;5953.76184952597;6066.332703402711;6073.605215660968;6075.908861367171;6082.391760823883;6097.390260973867;5763.221965034667;5768.048272035067;5768.826935191951;5772.134179873053;5778.855528611818;5579.525740312119;5798.333191682842;5820.70896455184;5861.853453663693;5961.135635332939;5761.222234998221;5771.422857714195;5780.566457515787;5783.421657834183;5787.8553036174435;5712.6286791358425;5716.742746576498;5769.653820770767;5781.82654520365;5783.248177736868;5460.153676180198;5477.616566840283;5508.834734957958;5518.724063796874;5626.606137570495;5695.345035320991;5718.51392631631;5751.338596061507;5755.251817263729;5767;5588.3573389060775;5621;5627.831165065055;5629.3244810621345;5630.380658127521 06:13:25 INFO - PROCESS | 3462 | |1;ext.html;557.1698169727108;561.5535649158918;573.5354362965998;584.5878655547839;613.2977740487141;42512.78743606281;44406.88982775428;44509.554904450946;44562.777186114065;48577.75711121439;44511.55488445114;45228;45255;45292;45314.54685453144;8881.422707524023;9087.727368178965;9095.408798428081;9097.954510227473;9130.452172869616;8934.419262747933;9054.818903621923;9056.184943355096;9060.365774395763;9077.591508382138;9010.819783604324;9085.54572271387;9116.316276279273;9125.224355929753;9132.497712625804;9036.186743193111;9089.590968406437;9102.499362535058;9103.226225770817;9105.817883642356;8972.461652300817;9051.81896362069;9052.909470905339;9061.728148155566;9066.274698024143;43418;43736;43781;43920.3411948821;43983.560164398266;3369.157710572357;3420.6921377075932;3422.57217847769;3642.653947874974;3951.5455722591696;32961.505577416356;33058.83470582656;33094.6690533094;33311.83344083288;35229.823850880835;4310.418093557361;4414.205443020255;4415.558444155591;4591.678582499227;4599.080183963188;348079;348643;349642;353093;354265;57108.714456428286;57132.71433642805;57399;57582;57690.711546442;60762;60829.69585152046;60886.69556652277;60905.69547152236;60929.39070609326;14948.40206391754;15198.088114713153;15205.31576079079;15220.695586088437;15224.391024359124;10853.131749460024;10894.782104357868;10996.12031037515;11011.83482247767;11017.283876548;13883.791743123862;16135.83864161367;16169.838301617068;16192.838071619133;16219.27013284405;4837;5999.670018149044;6096;6341.3341599132345;6375.394337537927;926.8007378413673;1021.371856308365;1050.485262221506;1094.43089593411;1135.3698697222956;33025.83487082597;34001.82999085038;34602.82698586542;37139.442908356395;37301;1050.3540322701635;1078.0674716370283;1146.4828575413012;1176.1061593189238;1206.837076994612;16435.342586296654;17294.567635809206;17377.826221737872;17451.47645570635;17492.47522574325;546092;546460;546706;547603;551846;56715.71642141763;56872.431275687544;57000.42999570034;57033.42966570364;57215.427845721846;1085.6525911708177;1366.8359796824245;1367.1660287224786;1378.4830688492016;1388.6667199871958;32180.356392871545;33184.33631327312;34125.31749365049;34206.315873682885;34362.8655202476;49700.50299497104;50178.49821501738;50204.49795502144;50227.49772502228;50285.49714502808;397156;399410;400251;400868;400935;27584.72415275902;27740.861295693394;28310.292242694097;28332.57501137526;28502.85748571244;45063.32405013993;47962.28056579085;48415.27377089276;49209;50185;40447.191056178126;41284.1743165129;41506.37740433956;41798.37302440405;43476.34785478157;40128.1974360517;40157;40488.1902361957;41492.585074148876;41791.37312940248;41605.79197103995;41820.79089604533;41880.58119418889;42508.78745606376;42669.50656726999;33773.29813614954;36949.261014780095;37051.62948370482;37733.4339984906;38007;27783.583246250917;28011.579826302215;28054.859725702056;28146.85926570436;29866.253343666584 06:13:25 INFO - PROCESS | 3462 | |2;jquery.html;351.46401737350556;383.5186840515155;388.6036243032107;391.205852120196;406.26060569763024;17087.487375378743;19297.614047719057;19357.322493712723;19613.11740971656;20263.49341266469;19630.509237269074;19730.802691973076;19987.500312492157;20207.49481262969;20357;5577.470140336682;5577.609567330278;5828.213191219194;5832.56255780816;6397.104405383227;6400.359964003585;6475.449586785129;6496.252930912935;6506.967465162667;6510.837229069264;6285.120083188357;6383.968080159592;6403.42260494942;6409.615423074607;6413.422791948724;6224.502039836802;6332.461740752042;6437.710303036374;6473.449756770657;6477.449416799578;5640.5769567282205;5648.209250704905;5654.547636189095;5660.632058916157;5664.178694089334;20911.8954405227;26127.608085878728;26220;26538;27493.725062749316;2456.1894574790454;2548.732383099766;2574.858382788946;2781.652293463317;3345.3309338132226;16171.676566468605;16658.916705416395;16660.75008874868;17258.3959561416;17268.30926762928;2042.1627132875449;2147.5597502511946;2159.589677961182;2168.609650262952;2205.095910676631;73262.63368683176;76286.63974087265;84116;90348.54825725895;99631.50184249032;14720.705585888223;17428.738568921475;18203.45389638313;18362.81637183638;18511.81488185101;32497.675023249936;32574.837125814218;32692.83653581717;32731.672683272864;32758.508622370682;8576.44253123545;8780.648774048967;9276.304277179239;9308.534573271309;9544.33189676716;7472.9252707473315;7577.886331705029;7730.420218483636;7760.146383897767;7803.68785248595;8879;9123.954380228057;9333.966460900234;9413.811723765622;9518.857217141749;3070.631524217108;3130.233092892256;3468.5642727941063;3485.4074807282823;3511.824408779602;856.07543852639;910.740438974889;942.2979879989451;959.7168835193635;979.0796651147898;20150.39548813538;21038.158473660882;21060.473488162614;21160.78839211619;21231.36305910825;944.6882528765491;980.6273616025865;1018.6485662446444;1022.5551884930079;1038.8753349598096;11009.559617615367;11418.257813242113;11443.874848857238;11566;11626.825597616042;487351;487754;488675;509851;510219;91438;92125;92668.53665731628;92796.53601731948;95764.52117739506;824.1799409587499;949.4635530925005;985.9901400986042;996.9750756231152;999.2206079258045;16177.757333639769;17204.65590688154;18439.170237339622;19164.233430662618;19204.519887002378;44853;46022.76988615035;46100.538994609626;46464.767676161406;47583.52416475791;59128.704356477945;60067.39932600618;60390.39609603848;60466.39533604783;63770;8623.784405389915;8969.192772650493;8974.551272436483;9044.41211321262;9292.674756383765;10473.528691208761;13795.379207935868;13817;13878.167309961435;13894.583162505141;12026.75946481048;12268.938655306667;12348.629541113782;12556.183848049848;12898.871011289766;11956.70108247266;11999.460024299102;12090.818637720266;12107.697307567028;12283.508659653513;9802.558884850056;12406.62780116598;12423.875761242634;12489.625311240678;12590.496380144692;8918.509481978554;8962.955185224033;8964.68623598171;9382;9532.808398950132;10562.419066951392;12208.023358131151;12257.69355766113;12291.938540307241;12308.446119924803 06:13:25 INFO - PROCESS | 3462 | |3;mootools.html;1436.2603259321452;1475.2918599072445;1572.866306363959;1689.9408520701777;1699.5920978965053;8401.159884011604;9110.362274640778;9113.772155696102;9115.54422278885;9118.544072796367;7057.823554411142;8416.957915210416;8621.310295176387;8673;8959.73120806377;2441.7314095449487;2460.2373264288126;2472.3942634054592;2472.7279999200073;2476.566600844854;2405.0740464921046;2454.355581760216;2460.4463995601027;2471.1845091119976;2482.2056941778637;2416.6495858100566;2418.032786885251;2430.744771798962;2437.9512409751796;2439.9756002439926;2357.57563638545;2364.7871691547757;2369.732193276606;2369.9763002370014;2396.4607963208314;2320.8027317678016;2338.5206032763413;2341.0869760793303;2345.1088586337255;2352.635341522067;8937.46375217489;9015.459072455673;9016.278697704169;9018.36871419001;9018.954905225432;5306.602004849613;5477.67133971959;5506.146547285177;5508.14623733322;5520.420355862657;3580.427131658922;3605.8016809075752;3633.6729694327373;3646.453032045188;3676.889693309205;1173.97065073373;1175.9588414405541;1182.8757980412106;1217.9391030448442;1225.9080568957363;12528.874711252862;12533;12535.623931282076;12535.874641253562;12552.874471255353;4684.906301873943;4696.410928619622;4735.573798358164;4741.288806679026;4936.432310284292;10437.478126093665;10445.634402795866;10451.372917624967;10560.419176945188;10598.735031624272;5392.433794451605;5423.511883930465;5424.294841670558;5425.26758887553;5426.375966763872;3941.4087886817206;4904.6321525885705;4933.876653083702;5003.399592048904;5013.323201367769;4032.354823228269;4072.552019277877;4092.529359123679;4187.057911969782;4218.514870789837;1291.9289439080753;1295.2163940815672;1307.8888294495075;1310.1091257944688;1316.927568983715;974.9171320437842;1003.5383723487278;1004.6132239088004;1004.6433516101824;1020.3826684855704;6106.389361063858;6201.224846894138;6276.372362763687;6464.903026454513;6504.3495650435525;434.758708916548;439.5670115423742;442.69896470400437;446.19016485079476;1035.1873779083535;4001.8599349022643;4238.766867822299;4267.591694740728;4293.97853010733;4301.3117901135665;10908.727281817859;11359.716007099889;11368.602098926498;11370.658880233606;11382.829257561143;11289.15331350152;11298.661040168809;11307.830382544269;11328;11346.489407976496;8316.916830831615;8329.083800782031;8443.184715286243;8456.323494120456;8481.618327175293;6042.395760424099;6157.784477543264;6188.369942774213;6201;6215.906761398493;9863.161631261422;9981.750456238653;10129.037741414553;10210.795784084128;10333.48332583383;10149.543270552991;10214.591416343263;10389.220808439548;10494.370337779757;10508.211884108876;6761.492888033319;6966.895496567454;6970.581765094111;8052.83894322122;8337.166283371856;7678.923210768045;8432.114627964222;8695;8728.039915609404;9005.63977440895;7915.525068495908;7925.326347260548;8105.27052565272;8176.305014073871;8199.754007379788;7782.688692452239;7787.92212077872;7824.530528168328;7849.411294152847;7924.84150317002;7068.151821781419;7151.177614574182;7152.821179470555;7153.570785752871;7156.355927966508;5314.176302673091;5388.973055134699;5444.8366549003595;5493.148561972901;5671.17767923657;5313.946860531345;5486.533644640091;5565.6104072714525;5568.610197286151;5593.4126916674795 06:13:25 INFO - PROCESS | 3462 | |4;prototype.html;332.14638379365033;335.5872277099168;341.1947803184485;347.10447046619726;349.7604141163302;5194.168932970725;5235.764390602418;5239.318888544493;5253.50091741284;5293.920591191126;5198.506141916521;5215.374155101393;5267.683938963665;5290.6825590464505;5291.761870715817;3958.4062390641348;3979.9602003980026;4109.445224894645;4151.107511884944;4167.666586673074;4144.896377590554;4148.211839750437;4151.854685086023;4168.062186008155;4172.499300083994;4094.8566800162002;4112.198121366319;4114.773687447189;4120.938185927213;4127.422160897477;3941.1920556286036;3949.2693851637396;4118.91762164758;4146.087860670677;4149;3648.4709717090873;3655;3659.4327879178504;3666.6883314918264;3692.464592634053;5126.231065340192;5168.198929165986;5175.197844334097;5208.932168905403;5218;4499.662525310615;4662.3705799716945;4702.788374523155;4710.858674239778;4816.373871396731;5514.834554963358;5524.917126243109;5537.390887002467;5546.918350921572;5553.16702494625;3948.6841052715713;3972.106276087886;3979.6816254699556;3980.442738016651;3983.721139520235;5555.777768889239;5724.656520608777;5767.394423585505;5774.595778295479;5792.68140252286;4104.753714777123;4113.449661210069;4128.442660240889;4128.483939507561;4138.8344466221015;4176.206520761046;4178.662827895045;4187.371894215831;4190.20386126635;4193.958060419418;4551.1100451213715;4658.34783130362;4724.196886529298;4730.905381892412;4771.4512831024185;5477.972610136924;5497.615166938356;5515.641483303572;5550.111982082847;5550.972245138829;1395.7696979998389;1432.8680342529285;1433.1114708880352;1440;1441.373002743789;858.043281740867;907.5280853956037;932.4871320773548;940.6736501532806;955.1403736636944;5174.715390653475;5310.2831117798605;5356.250124982505;5368.570514358842;5371.301730775052;5580.86047848807;5627.577931655061;5669.716514174274;5751.1373294006235;5754.223179870748;5099.745012749348;5357.678539287655;5362.410134885159;5369.476346117319;5381.300430943952;3002.1593953693;3051.832149231769;3053.0382929377174;3056.724894759482;3059.892903748358;5917;5930.657390330795;5946.345901950782;5964.135200395918;5989.341172471025;5630.40880707528;5787.623804452782;5820.35976042635;5830.53355731549;5847.94152058474;5814.563907706939;5868.413158684183;5881.941180588225;5891.587588868738;5913.852153696192;5404.594655400782;5678.290213723285;5688.459596338341;5714.228579141929;5720.6853623049465;5679.687617180929;5686.857828554319;5702.714864256854;5710.543156547549;5710.857228569319;5957.285125784933;5964.359801054571;5973.611715238496;5973.641581505123;5973.910391344047;3970.265500882346;4082.5509193989233;4113.519133112137;4113.609207125438;4128.958710412858;5723;5738.942610573841;5748.827535173951;5748.942510575008;5760.539156867357;5417.6478528895495;5625.718714064362;5637.43625637433;5654.943450565442;5661.433856614306;5545.390007099135;5549.334079910436;5559.777608895599;5587.776488940397;5601.691906945157;5507.284053073236;5516.172574113915;5561.916571251515;5573.108302671553;5573.5819813513335;5374.838754837361;5414.538074719725;5595.244641973444;5602.719864006865;5641.464060914206;5438.809641662681;5454.481824226692;5474.91787623194;5531.751071201886;5538.224648549126 06:13:25 INFO - PROCESS | 3462 | |5;yui.html;763.7823220382193;829.9577097921145;840.743573210171;850.2008112374367;892;13930.442782288708;14846.331915063822;14868.553943381703;14878.776818347733;14882.553523394303;13736.587902362946;14212.573622791308;16186.433474828384;16388.426405075825;16471.34114635416;798.1180795221284;826.8801023851538;832.6794184239081;832.7376876283981;833.7332053742805;502.3318985748945;794.0749027383121;810.8743144812563;812.8333691593209;828.9253967142956;848.321342925657;851.8637018077109;851.9914800852005;852.9616167272457;853.3130829682103;847.7287268074218;847.8007668197969;849.2059923971045;849.524266410812;850.8128211793427;381.7728451571311;388.03766658686334;392.27429255876683;611.5963464113709;625.3027873920591;15505.379784808594;15620.76568851468;15623.453179138676;15649.765253521206;15658.68682626341;13625;13865.930670346685;14036.438542458289;14227.78658320126;14512.78230826528;13519.188848669111;13630.795538066937;13770.586882393543;13842.861571384257;13900;4463.553644635511;4482.305242687388;4519.254323036695;4539.432570928634;4592.7933243004145;80343;81179.18820811716;81316.15393461201;82048;83031;11650.242734222249;11717.824232636518;11724.824127638092;11821.290722556674;12232.143749937419;18503.629927401376;18561.81438185628;18567;18577.349792757188;18612.534686632942;8096.959515202504;8321.08468068512;8456;8548.145185481402;8716.738497845075;4523.479799823062;4545.613622842029;4563.840265590688;4566.862994110182;4683.859484215479;3304.9173770655925;3482.373172828915;3483.303339332093;3487.4245749451056;3488;581.8399940016444;593.4747748242836;596.6777939912399;603.9456448919618;608.850831546274;587.4595372257534;625.1716475669756;671.4494114825893;677.7593954146207;678.2471456683078;9511;10037.69886903394;10042.69871903844;10151.695449136538;10267.229957753198;700.2927043685914;701.551007355293;702.2977022977022;719.2735337309251;723.5875550936021;4520.547945205453;4913.354026401124;4955.306257124005;4974.253861920669;4975.328330675385;76404.61797690977;77970.47398601116;93435;124838;128229.35885320514;101038;110797;111358;114221;116202.41898790452;67501.66249168722;93958;97954;97977.51011244899;98887.01112988777;9259.953700231456;9394.95302523483;9532.714018579454;9691.757706057122;9704.854427183456;55725.44274557203;56982.430175697715;57621.711891440274;57798.13302800545;58301.416985831296;76123.61938190274;81664.59167704123;82975.585122074;83663;87505;12372.566960156351;12544.811827822408;12617.179883307555;12622.368881556069;12871.806922896352;12448.688782780502;12641.3679316032;13122.60632181036;13385;13552.186868787905;12757.55348562796;12784.959810001965;12911.289879056741;13439.932800335935;13935.790963135358;12750.936245318713;12877.871221288042;12937.870621293667;13367.799483007568;13803.585892423243;11778.411079446165;11892.227005244631;12570.937145314581;13192.142510736772;13250;10671.733206669895;10756.070888199643;10793.352398856094;11099.445027748741;11394.487248074023;10182.134518566005;10270.178385729274;10285.74285642835;10612;10659.360438373722 06:13:25 INFO - PROCESS | 3462 | __end_tp_report 06:13:25 INFO - PROCESS | 3462 | __start_cc_report 06:13:25 INFO - PROCESS | 3462 | _x_x_mozilla_cycle_collect,1009 06:13:25 INFO - PROCESS | 3462 | __end_cc_report 06:13:25 INFO - PROCESS | 3462 | __startTimestamp1471094005726__endTimestamp 06:13:25 INFO - PROCESS | 3462 | 06:13:25 INFO - PROCESS | 3462 | ------- Summary: start ------- 06:13:25 INFO - PROCESS | 3462 | Number of tests: 6 06:13:25 INFO - PROCESS | 3462 | 06:13:25 INFO - PROCESS | 3462 | [#0] dojo.html Cycles:165 Average:5407.46 Median:5621.00 stddev:638.62 (11.4%) stddev-sans-first:613.03 06:13:25 INFO - PROCESS | 3462 | Values: 3042.3 3069.7 3070.8 3082.9 3088.8 5256.1 5303.2 5349.6 5387.9 5433.0 5364.6 5407.2 5425.7 5462.2 5528.3 4882.6 4910.8 4982.9 4986.9 5073.1 4989.4 5013.2 5034.7 5048.9 5049.4 4768.3 4874.9 4896.7 4930.1 4932.5 4869.8 4879.0 4883.1 4951.6 4988.6 4905.0 4936.3 4937.9 4947.3 4986.3 5297.5 5377.5 5450.5 5459.7 5514.5 5902.5 5922.2 5924.6 5933.5 5937.7 5624.7 5889.3 5910.8 5920.2 5968.9 5368.0 5423.5 5426.0 5526.3 5526.7 6052.5 6058.7 6060.0 6060.5 6063.5 5529.4 5749.4 5787.0 5793.8 5798.4 5752.9 5768.1 5802.5 5877.1 5887.3 5757.9 5810.4 5812.9 5816.3 5863.6 5768.6 5827.4 5832.1 5838.7 5867.9 4338.8 4358.7 4366.5 4444.7 4449.5 3922.5 3947.7 3968.3 4047.1 4071.7 5503.8 5505.6 5510.2 5512.6 5553.3 5895.9 5896.9 5899.2 5901.6 5910.3 5245.2 5374.5 5416.6 5417.8 5505.6 4860.8 4894.6 4899.3 4900.4 4932.0 5981.4 5983.0 5987.0 5993.1 6009.2 5638.6 5776.2 5840.1 5850.4 5953.8 6066.3 6073.6 6075.9 6082.4 6097.4 5763.2 5768.0 5768.8 5772.1 5778.9 5579.5 5798.3 5820.7 5861.9 5961.1 5761.2 5771.4 5780.6 5783.4 5787.9 5712.6 5716.7 5769.7 5781.8 5783.2 5460.2 5477.6 5508.8 5518.7 5626.6 5695.3 5718.5 5751.3 5755.3 5767.0 5588.4 5621.0 5627.8 5629.3 5630.4 06:13:25 INFO - PROCESS | 3462 | 06:13:25 INFO - PROCESS | 3462 | [#1] ext.html Cycles:180 Average:59667.82 Median:42194.68 stddev:116838.51 (276.9%) stddev-sans-first:117081.98 06:13:25 INFO - PROCESS | 3462 | Values: 557.2 561.6 573.5 584.6 613.3 42512.8 44406.9 44509.6 44562.8 48577.8 44511.6 45228.0 45255.0 45292.0 45314.5 8881.4 9087.7 9095.4 9098.0 9130.5 8934.4 9054.8 9056.2 9060.4 9077.6 9010.8 9085.5 9116.3 9125.2 9132.5 9036.2 9089.6 9102.5 9103.2 9105.8 8972.5 9051.8 9052.9 9061.7 9066.3 43418.0 43736.0 43781.0 43920.3 43983.6 3369.2 3420.7 3422.6 3642.7 3951.5 32961.5 33058.8 33094.7 33311.8 35229.8 4310.4 4414.2 4415.6 4591.7 4599.1 348079.0 348643.0 349642.0 353093.0 354265.0 57108.7 57132.7 57399.0 57582.0 57690.7 60762.0 60829.7 60886.7 60905.7 60929.4 14948.4 15198.1 15205.3 15220.7 15224.4 10853.1 10894.8 10996.1 11011.8 11017.3 13883.8 16135.8 16169.8 16192.8 16219.3 4837.0 5999.7 6096.0 6341.3 6375.4 926.8 1021.4 1050.5 1094.4 1135.4 33025.8 34001.8 34602.8 37139.4 37301.0 1050.4 1078.1 1146.5 1176.1 1206.8 16435.3 17294.6 17377.8 17451.5 17492.5 546092.0 546460.0 546706.0 547603.0 551846.0 56715.7 56872.4 57000.4 57033.4 57215.4 1085.7 1366.8 1367.2 1378.5 1388.7 32180.4 33184.3 34125.3 34206.3 34362.9 49700.5 50178.5 50204.5 50227.5 50285.5 397156.0 399410.0 400251.0 400868.0 400935.0 27584.7 27740.9 28310.3 28332.6 28502.9 45063.3 47962.3 48415.3 49209.0 50185.0 40447.2 41284.2 41506.4 41798.4 43476.3 40128.2 40157.0 40488.2 41492.6 41791.4 41605.8 41820.8 41880.6 42508.8 42669.5 33773.3 36949.3 37051.6 37733.4 38007.0 27783.6 28011.6 28054.9 28146.9 29866.3 06:13:25 INFO - PROCESS | 3462 | 06:13:25 INFO - PROCESS | 3462 | [#2] jquery.html Cycles:180 Average:30866.66 Median:398.73 stddev:81823.38 (20520.8%) stddev-sans-first:82020.84 06:13:25 INFO - PROCESS | 3462 | Values: 351.5 383.5 388.6 391.2 406.3 17087.5 19297.6 19357.3 19613.1 20263.5 19630.5 19730.8 19987.5 20207.5 20357.0 5577.5 5577.6 5828.2 5832.6 6397.1 6400.4 6475.4 6496.3 6507.0 6510.8 6285.1 6384.0 6403.4 6409.6 6413.4 6224.5 6332.5 6437.7 6473.4 6477.4 5640.6 5648.2 5654.5 5660.6 5664.2 20911.9 26127.6 26220.0 26538.0 27493.7 2456.2 2548.7 2574.9 2781.7 3345.3 16171.7 16658.9 16660.8 17258.4 17268.3 2042.2 2147.6 2159.6 2168.6 2205.1 73262.6 76286.6 84116.0 90348.5 99631.5 14720.7 17428.7 18203.5 18362.8 18511.8 32497.7 32574.8 32692.8 32731.7 32758.5 8576.4 8780.6 9276.3 9308.5 9544.3 7472.9 7577.9 7730.4 7760.1 7803.7 8879.0 9124.0 9334.0 9413.8 9518.9 3070.6 3130.2 3468.6 3485.4 3511.8 856.1 910.7 942.3 959.7 979.1 20150.4 21038.2 21060.5 21160.8 21231.4 944.7 980.6 1018.6 1022.6 1038.9 11009.6 11418.3 11443.9 11566.0 11626.8 487351.0 487754.0 488675.0 509851.0 510219.0 91438.0 92125.0 92668.5 92796.5 95764.5 824.2 949.5 986.0 997.0 999.2 16177.8 17204.7 18439.2 19164.2 19204.5 44853.0 46022.8 46100.5 46464.8 47583.5 59128.7 60067.4 60390.4 60466.4 63770.0 8623.8 8969.2 8974.6 9044.4 9292.7 10473.5 13795.4 13817.0 13878.2 13894.6 12026.8 12268.9 12348.6 12556.2 12898.9 11956.7 11999.5 12090.8 12107.7 12283.5 9802.6 12406.6 12423.9 12489.6 12590.5 8918.5 8963.0 8964.7 9382.0 9532.8 10562.4 12208.0 12257.7 12291.9 12308.4 06:13:25 INFO - PROCESS | 3462 | 06:13:25 INFO - PROCESS | 3462 | [#3] mootools.html Cycles:180 Average:5924.26 Median:441.13 stddev:3354.86 (760.5%) stddev-sans-first:3347.31 06:13:25 INFO - PROCESS | 3462 | Values: 1436.3 1475.3 1572.9 1689.9 1699.6 8401.2 9110.4 9113.8 9115.5 9118.5 7057.8 8417.0 8621.3 8673.0 8959.7 2441.7 2460.2 2472.4 2472.7 2476.6 2405.1 2454.4 2460.4 2471.2 2482.2 2416.6 2418.0 2430.7 2438.0 2440.0 2357.6 2364.8 2369.7 2370.0 2396.5 2320.8 2338.5 2341.1 2345.1 2352.6 8937.5 9015.5 9016.3 9018.4 9019.0 5306.6 5477.7 5506.1 5508.1 5520.4 3580.4 3605.8 3633.7 3646.5 3676.9 1174.0 1176.0 1182.9 1217.9 1225.9 12528.9 12533.0 12535.6 12535.9 12552.9 4684.9 4696.4 4735.6 4741.3 4936.4 10437.5 10445.6 10451.4 10560.4 10598.7 5392.4 5423.5 5424.3 5425.3 5426.4 3941.4 4904.6 4933.9 5003.4 5013.3 4032.4 4072.6 4092.5 4187.1 4218.5 1291.9 1295.2 1307.9 1310.1 1316.9 974.9 1003.5 1004.6 1004.6 1020.4 6106.4 6201.2 6276.4 6464.9 6504.3 434.8 439.6 442.7 446.2 1035.2 4001.9 4238.8 4267.6 4294.0 4301.3 10908.7 11359.7 11368.6 11370.7 11382.8 11289.2 11298.7 11307.8 11328.0 11346.5 8316.9 8329.1 8443.2 8456.3 8481.6 6042.4 6157.8 6188.4 6201.0 6215.9 9863.2 9981.8 10129.0 10210.8 10333.5 10149.5 10214.6 10389.2 10494.4 10508.2 6761.5 6966.9 6970.6 8052.8 8337.2 7678.9 8432.1 8695.0 8728.0 9005.6 7915.5 7925.3 8105.3 8176.3 8199.8 7782.7 7787.9 7824.5 7849.4 7924.8 7068.2 7151.2 7152.8 7153.6 7156.4 5314.2 5389.0 5444.8 5493.1 5671.2 5313.9 5486.5 5565.6 5568.6 5593.4 06:13:25 INFO - PROCESS | 3462 | 06:13:25 INFO - PROCESS | 3462 | [#4] prototype.html Cycles:180 Average:4685.50 Median:5365.49 stddev:1379.26 (25.7%) stddev-sans-first:1343.87 06:13:25 INFO - PROCESS | 3462 | Values: 332.1 335.6 341.2 347.1 349.8 5194.2 5235.8 5239.3 5253.5 5293.9 5198.5 5215.4 5267.7 5290.7 5291.8 3958.4 3980.0 4109.4 4151.1 4167.7 4144.9 4148.2 4151.9 4168.1 4172.5 4094.9 4112.2 4114.8 4120.9 4127.4 3941.2 3949.3 4118.9 4146.1 4149.0 3648.5 3655.0 3659.4 3666.7 3692.5 5126.2 5168.2 5175.2 5208.9 5218.0 4499.7 4662.4 4702.8 4710.9 4816.4 5514.8 5524.9 5537.4 5546.9 5553.2 3948.7 3972.1 3979.7 3980.4 3983.7 5555.8 5724.7 5767.4 5774.6 5792.7 4104.8 4113.4 4128.4 4128.5 4138.8 4176.2 4178.7 4187.4 4190.2 4194.0 4551.1 4658.3 4724.2 4730.9 4771.5 5478.0 5497.6 5515.6 5550.1 5551.0 1395.8 1432.9 1433.1 1440.0 1441.4 858.0 907.5 932.5 940.7 955.1 5174.7 5310.3 5356.3 5368.6 5371.3 5580.9 5627.6 5669.7 5751.1 5754.2 5099.7 5357.7 5362.4 5369.5 5381.3 3002.2 3051.8 3053.0 3056.7 3059.9 5917.0 5930.7 5946.3 5964.1 5989.3 5630.4 5787.6 5820.4 5830.5 5847.9 5814.6 5868.4 5881.9 5891.6 5913.9 5404.6 5678.3 5688.5 5714.2 5720.7 5679.7 5686.9 5702.7 5710.5 5710.9 5957.3 5964.4 5973.6 5973.6 5973.9 3970.3 4082.6 4113.5 4113.6 4129.0 5723.0 5738.9 5748.8 5748.9 5760.5 5417.6 5625.7 5637.4 5654.9 5661.4 5545.4 5549.3 5559.8 5587.8 5601.7 5507.3 5516.2 5561.9 5573.1 5573.6 5374.8 5414.5 5595.2 5602.7 5641.5 5438.8 5454.5 5474.9 5531.8 5538.2 06:13:25 INFO - PROCESS | 3462 | 06:13:25 INFO - PROCESS | 3462 | [#5] yui.html Cycles:180 Average:21250.49 Median:4500.78 stddev:31155.64 (692.2%) stddev-sans-first:31205.07 06:13:25 INFO - PROCESS | 3462 | Values: 763.8 830.0 840.7 850.2 892.0 13930.4 14846.3 14868.6 14878.8 14882.6 13736.6 14212.6 16186.4 16388.4 16471.3 798.1 826.9 832.7 832.7 833.7 502.3 794.1 810.9 812.8 828.9 848.3 851.9 852.0 853.0 853.3 847.7 847.8 849.2 849.5 850.8 381.8 388.0 392.3 611.6 625.3 15505.4 15620.8 15623.5 15649.8 15658.7 13625.0 13865.9 14036.4 14227.8 14512.8 13519.2 13630.8 13770.6 13842.9 13900.0 4463.6 4482.3 4519.3 4539.4 4592.8 80343.0 81179.2 81316.2 82048.0 83031.0 11650.2 11717.8 11724.8 11821.3 12232.1 18503.6 18561.8 18567.0 18577.3 18612.5 8097.0 8321.1 8456.0 8548.1 8716.7 4523.5 4545.6 4563.8 4566.9 4683.9 3304.9 3482.4 3483.3 3487.4 3488.0 581.8 593.5 596.7 603.9 608.9 587.5 625.2 671.4 677.8 678.2 9511.0 10037.7 10042.7 10151.7 10267.2 700.3 701.6 702.3 719.3 723.6 4520.5 4913.4 4955.3 4974.3 4975.3 76404.6 77970.5 93435.0 124838.0 128229.4 101038.0 110797.0 111358.0 114221.0 116202.4 67501.7 93958.0 97954.0 97977.5 98887.0 9260.0 9395.0 9532.7 9691.8 9704.9 55725.4 56982.4 57621.7 57798.1 58301.4 76123.6 81664.6 82975.6 83663.0 87505.0 12372.6 12544.8 12617.2 12622.4 12871.8 12448.7 12641.4 13122.6 13385.0 13552.2 12757.6 12785.0 12911.3 13439.9 13935.8 12750.9 12877.9 12937.9 13367.8 13803.6 11778.4 11892.2 12570.9 13192.1 13250.0 10671.7 10756.1 10793.4 11099.4 11394.5 10182.1 10270.2 10285.7 10612.0 10659.4 06:13:25 INFO - PROCESS | 3462 | -------- Summary: end -------- 06:13:25 INFO - PROCESS | 3462 | 06:13:26 INFO - TEST-INFO | 3462: exit 0 06:13:26 INFO - TEST-OK | dromaeo_css | took 1116796ms 06:13:26 INFO - TEST-START | kraken 06:13:26 INFO - operating with platform_type : linux_ 06:13:26 INFO - Initialising browser for kraken test... 06:13:26 INFO - TEST-INFO | started process 3769 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp47z_3a/profile http://localhost:56509/getInfo.html) 06:13:30 INFO - PROCESS | 3769 | __metrics Screen width/height:1600/1200 06:13:30 INFO - PROCESS | 3769 | colorDepth:24 06:13:30 INFO - PROCESS | 3769 | Browser inner width/height: 1024/697 06:13:30 INFO - PROCESS | 3769 | __metrics 06:13:31 INFO - PROCESS | 3769 | 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" 06:13:31 INFO - PROCESS | 3769 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:13:32 INFO - TEST-INFO | 3769: exit 0 06:13:32 INFO - Browser initialized. 06:13:32 INFO - Running cycle 1/1 for kraken test... 06:13:32 INFO - TEST-INFO | started process 3854 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp47z_3a/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:13:44 INFO - PROCESS | 3854 | RSS: Main: 156016640 06:13:44 INFO - PROCESS | 3854 | 06:13:46 INFO - PROCESS | 3854 | Cycle 1(1): loaded http://localhost:56509/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56509/tests/kraken/driver.html?testName=audio-beat-detection) 06:13:47 INFO - PROCESS | 3854 | RSS: Main: 204439552 06:13:47 INFO - PROCESS | 3854 | 06:13:50 INFO - PROCESS | 3854 | Cycle 1(1): loaded http://localhost:56509/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56509/tests/kraken/driver.html?testName=audio-dft) 06:13:50 INFO - PROCESS | 3854 | RSS: Main: 195530752 06:13:50 INFO - PROCESS | 3854 | 06:13:54 INFO - PROCESS | 3854 | Cycle 1(1): loaded http://localhost:56509/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56509/tests/kraken/driver.html?testName=audio-fft) 06:13:54 INFO - PROCESS | 3854 | RSS: Main: 275877888 06:13:54 INFO - PROCESS | 3854 | 06:13:56 INFO - PROCESS | 3854 | Cycle 1(1): loaded http://localhost:56509/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56509/tests/kraken/driver.html?testName=audio-oscillator) 06:13:57 INFO - PROCESS | 3854 | RSS: Main: 186290176 06:13:57 INFO - PROCESS | 3854 | 06:13:59 INFO - PROCESS | 3854 | Cycle 1(1): loaded http://localhost:56509/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56509/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:14:00 INFO - PROCESS | 3854 | RSS: Main: 191332352 06:14:00 INFO - PROCESS | 3854 | 06:14:03 INFO - PROCESS | 3854 | Cycle 1(1): loaded http://localhost:56509/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56509/tests/kraken/driver.html?testName=imaging-darkroom) 06:14:03 INFO - PROCESS | 3854 | RSS: Main: 225824768 06:14:03 INFO - PROCESS | 3854 | 06:14:07 INFO - PROCESS | 3854 | Cycle 1(1): loaded http://localhost:56509/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56509/tests/kraken/driver.html?testName=imaging-desaturate) 06:14:07 INFO - PROCESS | 3854 | RSS: Main: 226074624 06:14:07 INFO - PROCESS | 3854 | 06:14:10 INFO - PROCESS | 3854 | Cycle 1(1): loaded http://localhost:56509/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56509/tests/kraken/driver.html?testName=json-parse-financial) 06:14:11 INFO - PROCESS | 3854 | RSS: Main: 226172928 06:14:11 INFO - PROCESS | 3854 | 06:14:12 INFO - PROCESS | 3854 | Cycle 1(1): loaded http://localhost:56509/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56509/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:14:13 INFO - PROCESS | 3854 | RSS: Main: 188764160 06:14:13 INFO - PROCESS | 3854 | 06:14:14 INFO - PROCESS | 3854 | Cycle 1(1): loaded http://localhost:56509/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56509/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:14:15 INFO - PROCESS | 3854 | RSS: Main: 195850240 06:14:15 INFO - PROCESS | 3854 | 06:14:17 INFO - PROCESS | 3854 | Cycle 1(1): loaded http://localhost:56509/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56509/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:14:18 INFO - PROCESS | 3854 | RSS: Main: 193601536 06:14:18 INFO - PROCESS | 3854 | 06:14:20 INFO - PROCESS | 3854 | Cycle 1(1): loaded http://localhost:56509/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56509/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:14:21 INFO - PROCESS | 3854 | RSS: Main: 187416576 06:14:21 INFO - PROCESS | 3854 | 06:14:24 INFO - PROCESS | 3854 | Cycle 1(1): loaded http://localhost:56509/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56509/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:14:24 INFO - PROCESS | 3854 | RSS: Main: 191909888 06:14:24 INFO - PROCESS | 3854 | 06:14:26 INFO - PROCESS | 3854 | Cycle 1(1): loaded http://localhost:56509/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56509/tests/kraken/driver.html?testName=ai-astar) 06:14:26 INFO - PROCESS | 3854 | RSS: Main: 242618368 06:14:26 INFO - PROCESS | 3854 | 06:14:26 INFO - PROCESS | 3854 | __start_tp_report 06:14:26 INFO - PROCESS | 3854 | _x_x_mozilla_page_load 06:14:26 INFO - PROCESS | 3854 | _x_x_mozilla_page_load_details 06:14:26 INFO - PROCESS | 3854 | |i|pagename|runs| 06:14:26 INFO - PROCESS | 3854 | |0;ai-astar;102;110;113;111;109;112;111;111;113;112 06:14:26 INFO - PROCESS | 3854 | |1;audio-beat-detection;147;115;122;183;124;117;145;122;155;120 06:14:26 INFO - PROCESS | 3854 | |2;audio-dft;161;160;160;160;160;159;161;163;160;161 06:14:26 INFO - PROCESS | 3854 | |3;audio-fft;76;74;75;111;76;75;75;76;120;76 06:14:26 INFO - PROCESS | 3854 | |4;audio-oscillator;84;84;140;86;85;86;126;85;84;131 06:14:26 INFO - PROCESS | 3854 | |5;imaging-gaussian-blur;117;117;117;117;116;117;116;118;120;118 06:14:26 INFO - PROCESS | 3854 | |6;imaging-darkroom;146;145;147;145;146;147;147;146;145;145 06:14:26 INFO - PROCESS | 3854 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;96;96 06:14:26 INFO - PROCESS | 3854 | |8;json-parse-financial;54;48;52;50;50;51;50;48;52;50 06:14:26 INFO - PROCESS | 3854 | |9;json-stringify-tinderbox;63;62;61;61;62;62;61;61;62;62 06:14:26 INFO - PROCESS | 3854 | |10;stanford-crypto-aes;79;78;77;77;81;83;78;78;76;77 06:14:26 INFO - PROCESS | 3854 | |11;stanford-crypto-ccm;128;123;123;121;124;122;125;131;152;132 06:14:26 INFO - PROCESS | 3854 | |12;stanford-crypto-pbkdf2;164;166;165;161;163;161;161;166;164;160 06:14:26 INFO - PROCESS | 3854 | |13;stanford-crypto-sha256-iterative;63;69;63;65;68;64;64;64;63;69 06:14:26 INFO - PROCESS | 3854 | __end_tp_report 06:14:26 INFO - PROCESS | 3854 | __start_cc_report 06:14:26 INFO - PROCESS | 3854 | _x_x_mozilla_cycle_collect,1681 06:14:26 INFO - PROCESS | 3854 | __end_cc_report 06:14:26 INFO - PROCESS | 3854 | __startTimestamp1471094066703__endTimestamp 06:14:26 INFO - PROCESS | 3854 | 06:14:26 INFO - PROCESS | 3854 | ------- Summary: start ------- 06:14:26 INFO - PROCESS | 3854 | Number of tests: 14 06:14:26 INFO - PROCESS | 3854 | 06:14:26 INFO - PROCESS | 3854 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.50 stddev:3.20 (2.9%) stddev-sans-first:1.32 06:14:26 INFO - PROCESS | 3854 | Values: 102.0 110.0 113.0 111.0 109.0 112.0 111.0 111.0 113.0 112.0 06:14:26 INFO - PROCESS | 3854 | 06:14:26 INFO - PROCESS | 3854 | [#1] audio-beat-detection Cycles:10 Average:135.00 Median:134.50 stddev:22.00 (16.4%) stddev-sans-first:22.90 06:14:26 INFO - PROCESS | 3854 | Values: 147.0 115.0 122.0 183.0 124.0 117.0 145.0 122.0 155.0 120.0 06:14:26 INFO - PROCESS | 3854 | 06:14:26 INFO - PROCESS | 3854 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.50 stddev:1.08 (0.7%) stddev-sans-first:1.13 06:14:26 INFO - PROCESS | 3854 | Values: 161.0 160.0 160.0 160.0 160.0 159.0 161.0 163.0 160.0 161.0 06:14:26 INFO - PROCESS | 3854 | 06:14:26 INFO - PROCESS | 3854 | [#3] audio-fft Cycles:10 Average:83.40 Median:75.50 stddev:17.06 (22.6%) stddev-sans-first:17.89 06:14:26 INFO - PROCESS | 3854 | Values: 76.0 74.0 75.0 111.0 76.0 75.0 75.0 76.0 120.0 76.0 06:14:26 INFO - PROCESS | 3854 | 06:14:26 INFO - PROCESS | 3854 | [#4] audio-oscillator Cycles:10 Average:99.10 Median:84.50 stddev:23.19 (27.4%) stddev-sans-first:23.94 06:14:26 INFO - PROCESS | 3854 | Values: 84.0 84.0 140.0 86.0 85.0 86.0 126.0 85.0 84.0 131.0 06:14:26 INFO - PROCESS | 3854 | 06:14:26 INFO - PROCESS | 3854 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:1.16 (1.0%) stddev-sans-first:1.22 06:14:26 INFO - PROCESS | 3854 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 116.0 118.0 120.0 118.0 06:14:26 INFO - PROCESS | 3854 | 06:14:26 INFO - PROCESS | 3854 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 06:14:26 INFO - PROCESS | 3854 | Values: 146.0 145.0 147.0 145.0 146.0 147.0 147.0 146.0 145.0 145.0 06:14:26 INFO - PROCESS | 3854 | 06:14:26 INFO - PROCESS | 3854 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 06:14:26 INFO - PROCESS | 3854 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 06:14:26 INFO - PROCESS | 3854 | 06:14:26 INFO - PROCESS | 3854 | [#8] json-parse-financial Cycles:10 Average:50.50 Median:50.50 stddev:1.84 (3.6%) stddev-sans-first:1.45 06:14:26 INFO - PROCESS | 3854 | Values: 54.0 48.0 52.0 50.0 50.0 51.0 50.0 48.0 52.0 50.0 06:14:26 INFO - PROCESS | 3854 | 06:14:26 INFO - PROCESS | 3854 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:62.00 stddev:0.67 (1.1%) stddev-sans-first:0.53 06:14:26 INFO - PROCESS | 3854 | Values: 63.0 62.0 61.0 61.0 62.0 62.0 61.0 61.0 62.0 62.0 06:14:26 INFO - PROCESS | 3854 | 06:14:26 INFO - PROCESS | 3854 | [#10] stanford-crypto-aes Cycles:10 Average:78.40 Median:78.00 stddev:2.12 (2.7%) stddev-sans-first:2.24 06:14:26 INFO - PROCESS | 3854 | Values: 79.0 78.0 77.0 77.0 81.0 83.0 78.0 78.0 76.0 77.0 06:14:26 INFO - PROCESS | 3854 | 06:14:26 INFO - PROCESS | 3854 | [#11] stanford-crypto-ccm Cycles:10 Average:128.10 Median:126.50 stddev:9.19 (7.3%) stddev-sans-first:9.75 06:14:26 INFO - PROCESS | 3854 | Values: 128.0 123.0 123.0 121.0 124.0 122.0 125.0 131.0 152.0 132.0 06:14:26 INFO - PROCESS | 3854 | 06:14:26 INFO - PROCESS | 3854 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.10 Median:164.00 stddev:2.23 (1.4%) stddev-sans-first:2.35 06:14:26 INFO - PROCESS | 3854 | Values: 164.0 166.0 165.0 161.0 163.0 161.0 161.0 166.0 164.0 160.0 06:14:26 INFO - PROCESS | 3854 | 06:14:26 INFO - PROCESS | 3854 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:64.50 stddev:2.49 (3.9%) stddev-sans-first:2.51 06:14:26 INFO - PROCESS | 3854 | Values: 63.0 69.0 63.0 65.0 68.0 64.0 64.0 64.0 63.0 69.0 06:14:26 INFO - PROCESS | 3854 | -------- Summary: end -------- 06:14:26 INFO - PROCESS | 3854 | 06:14:27 INFO - TEST-INFO | 3854: exit 0 06:14:27 INFO - TEST-OK | kraken | took 61218ms 06:14:27 INFO - SUITE-END | took 1178s 06:14:27 INFO - Completed test suite (00:19:38) 06:14:27 INFO - javascript benchmark 06:14:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3042.330687248805, 3069.677683843197, 3070.8464576771185, 3082.876684932603, 3088.7992280501767, 5256.080185967459, 5303.151495760679, 5349.5720342372615, 5387.91918121228, 5432.999999999995, 5364.5708343332535, 5407.215953686713, 5425.7287135643255, 5462.20797984293, 5528.336599608053, 4882.633802464811, 4910.75446227689, 4982.9252561211615, 4986.87532811679, 5073.112205364065, 4989.426215985171, 5013.197888337867, 5034.697918124906, 5048.873778155539, 5049.444561098277, 4768.260919557457, 4874.902501949977, 4896.730679812609, 4930.087933732253, 4932.482089380599, 4869.756512174413, 4879.024195160947, 4883.12103821312, 4951.628627852925, 4988.551030407244, 4905.0, 4936.33359496467, 4937.851864444073, 4947.282644016634, 4986.2769898364895, 5297.47025297471, 5377.489138531833, 5450.5367043800925, 5459.69971651559, 5514.503694667499, 5902.468777810018, 5922.170896074553, 5924.644521328734, 5933.465988061095, 5937.67342796146, 5624.71876406178, 5889.322727886305, 5910.822675319747, 5920.2007728956905, 5968.880622387528, 5368.0, 5423.457654234624, 5426.0, 5526.309211348582, 5526.668399896019, 6052.455279024909, 6058.727357268934, 6060.0, 6060.545459090586, 6063.454289114001, 5529.364123125812, 5749.367569567345, 5787.0, 5793.826185214451, 5798.362180160179, 5752.884942301214, 5768.105943578752, 5802.506786923159, 5877.089051197071, 5887.293524776968, 5757.9424205757405, 5810.360860305363, 5812.912806307909, 5816.331121921034, 5863.648181109062, 5768.625039372428, 5827.417258274223, 5832.12518122285, 5838.7080645967535, 5867.882642347129, 4338.783060846945, 4358.6730995175485, 4366.519682834885, 4444.73331600105, 4449.510553839075, 3922.5292964844402, 3947.7236593438183, 3968.305546529346, 4047.1096358801606, 4071.714979951434, 5503.779848806083, 5505.614606977473, 5510.173473978855, 5512.614117011771, 5553.250311208016, 5895.911561326584, 5896.941030589639, 5899.174115623816, 5901.5868889177345, 5910.290765108214, 5245.186996015624, 5374.4625537445945, 5416.620836541483, 5417.83746487606, 5505.559555235572, 4860.80556777732, 4894.583960363409, 4899.2896030075435, 4900.411950565955, 4932.038252540792, 5981.401859813984, 5982.970085149546, 5987.042073268256, 5993.0710739835395, 6009.1587177795145, 5638.5771067170945, 5776.19133321327, 5840.065589505659, 5850.356460789395, 5953.76184952597, 6066.332703402711, 6073.605215660968, 6075.908861367171, 6082.391760823883, 6097.390260973867, 5763.221965034667, 5768.048272035067, 5768.826935191951, 5772.134179873053, 5778.855528611818, 5579.525740312119, 5798.333191682842, 5820.70896455184, 5861.853453663693, 5961.135635332939, 5761.222234998221, 5771.422857714195, 5780.566457515787, 5783.421657834183, 5787.8553036174435, 5712.6286791358425, 5716.742746576498, 5769.653820770767, 5781.82654520365, 5783.248177736868, 5460.153676180198, 5477.616566840283, 5508.834734957958, 5518.724063796874, 5626.606137570495, 5695.345035320991, 5718.51392631631, 5751.338596061507, 5755.251817263729, 5767.0, 5588.3573389060775, 5621.0, 5627.831165065055, 5629.3244810621345, 5630.380658127521], "value": 5362.515166834809, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.1698169727108, 561.5535649158918, 573.5354362965998, 584.5878655547839, 613.2977740487141, 42512.78743606281, 44406.88982775428, 44509.554904450946, 44562.777186114065, 48577.75711121439, 44511.55488445114, 45228.0, 45255.0, 45292.0, 45314.54685453144, 8881.422707524023, 9087.727368178965, 9095.408798428081, 9097.954510227473, 9130.452172869616, 8934.419262747933, 9054.818903621923, 9056.184943355096, 9060.365774395763, 9077.591508382138, 9010.819783604324, 9085.54572271387, 9116.316276279273, 9125.224355929753, 9132.497712625804, 9036.186743193111, 9089.590968406437, 9102.499362535058, 9103.226225770817, 9105.817883642356, 8972.461652300817, 9051.81896362069, 9052.909470905339, 9061.728148155566, 9066.274698024143, 43418.0, 43736.0, 43781.0, 43920.3411948821, 43983.560164398266, 3369.157710572357, 3420.6921377075932, 3422.57217847769, 3642.653947874974, 3951.5455722591696, 32961.505577416356, 33058.83470582656, 33094.6690533094, 33311.83344083288, 35229.823850880835, 4310.418093557361, 4414.205443020255, 4415.558444155591, 4591.678582499227, 4599.080183963188, 348079.0, 348643.0, 349642.0, 353093.0, 354265.0, 57108.714456428286, 57132.71433642805, 57399.0, 57582.0, 57690.711546442, 60762.0, 60829.69585152046, 60886.69556652277, 60905.69547152236, 60929.39070609326, 14948.40206391754, 15198.088114713153, 15205.31576079079, 15220.695586088437, 15224.391024359124, 10853.131749460024, 10894.782104357868, 10996.12031037515, 11011.83482247767, 11017.283876548, 13883.791743123862, 16135.83864161367, 16169.838301617068, 16192.838071619133, 16219.27013284405, 4837.0, 5999.670018149044, 6096.0, 6341.3341599132345, 6375.394337537927, 926.8007378413673, 1021.371856308365, 1050.485262221506, 1094.43089593411, 1135.3698697222956, 33025.83487082597, 34001.82999085038, 34602.82698586542, 37139.442908356395, 37301.0, 1050.3540322701635, 1078.0674716370283, 1146.4828575413012, 1176.1061593189238, 1206.837076994612, 16435.342586296654, 17294.567635809206, 17377.826221737872, 17451.47645570635, 17492.47522574325, 546092.0, 546460.0, 546706.0, 547603.0, 551846.0, 56715.71642141763, 56872.431275687544, 57000.42999570034, 57033.42966570364, 57215.427845721846, 1085.6525911708177, 1366.8359796824245, 1367.1660287224786, 1378.4830688492016, 1388.6667199871958, 32180.356392871545, 33184.33631327312, 34125.31749365049, 34206.315873682885, 34362.8655202476, 49700.50299497104, 50178.49821501738, 50204.49795502144, 50227.49772502228, 50285.49714502808, 397156.0, 399410.0, 400251.0, 400868.0, 400935.0, 27584.72415275902, 27740.861295693394, 28310.292242694097, 28332.57501137526, 28502.85748571244, 45063.32405013993, 47962.28056579085, 48415.27377089276, 49209.0, 50185.0, 40447.191056178126, 41284.1743165129, 41506.37740433956, 41798.37302440405, 43476.34785478157, 40128.1974360517, 40157.0, 40488.1902361957, 41492.585074148876, 41791.37312940248, 41605.79197103995, 41820.79089604533, 41880.58119418889, 42508.78745606376, 42669.50656726999, 33773.29813614954, 36949.261014780095, 37051.62948370482, 37733.4339984906, 38007.0, 27783.583246250917, 28011.579826302215, 28054.859725702056, 28146.85926570436, 29866.253343666584], "value": 19959.142415699145, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.46401737350556, 383.5186840515155, 388.6036243032107, 391.205852120196, 406.26060569763024, 17087.487375378743, 19297.614047719057, 19357.322493712723, 19613.11740971656, 20263.49341266469, 19630.509237269074, 19730.802691973076, 19987.500312492157, 20207.49481262969, 20357.0, 5577.470140336682, 5577.609567330278, 5828.213191219194, 5832.56255780816, 6397.104405383227, 6400.359964003585, 6475.449586785129, 6496.252930912935, 6506.967465162667, 6510.837229069264, 6285.120083188357, 6383.968080159592, 6403.42260494942, 6409.615423074607, 6413.422791948724, 6224.502039836802, 6332.461740752042, 6437.710303036374, 6473.449756770657, 6477.449416799578, 5640.5769567282205, 5648.209250704905, 5654.547636189095, 5660.632058916157, 5664.178694089334, 20911.8954405227, 26127.608085878728, 26220.0, 26538.0, 27493.725062749316, 2456.1894574790454, 2548.732383099766, 2574.858382788946, 2781.652293463317, 3345.3309338132226, 16171.676566468605, 16658.916705416395, 16660.75008874868, 17258.3959561416, 17268.30926762928, 2042.1627132875449, 2147.5597502511946, 2159.589677961182, 2168.609650262952, 2205.095910676631, 73262.63368683176, 76286.63974087265, 84116.0, 90348.54825725895, 99631.50184249032, 14720.705585888223, 17428.738568921475, 18203.45389638313, 18362.81637183638, 18511.81488185101, 32497.675023249936, 32574.837125814218, 32692.83653581717, 32731.672683272864, 32758.508622370682, 8576.44253123545, 8780.648774048967, 9276.304277179239, 9308.534573271309, 9544.33189676716, 7472.9252707473315, 7577.886331705029, 7730.420218483636, 7760.146383897767, 7803.68785248595, 8879.0, 9123.954380228057, 9333.966460900234, 9413.811723765622, 9518.857217141749, 3070.631524217108, 3130.233092892256, 3468.5642727941063, 3485.4074807282823, 3511.824408779602, 856.07543852639, 910.740438974889, 942.2979879989451, 959.7168835193635, 979.0796651147898, 20150.39548813538, 21038.158473660882, 21060.473488162614, 21160.78839211619, 21231.36305910825, 944.6882528765491, 980.6273616025865, 1018.6485662446444, 1022.5551884930079, 1038.8753349598096, 11009.559617615367, 11418.257813242113, 11443.874848857238, 11566.0, 11626.825597616042, 487351.0, 487754.0, 488675.0, 509851.0, 510219.0, 91438.0, 92125.0, 92668.53665731628, 92796.53601731948, 95764.52117739506, 824.1799409587499, 949.4635530925005, 985.9901400986042, 996.9750756231152, 999.2206079258045, 16177.757333639769, 17204.65590688154, 18439.170237339622, 19164.233430662618, 19204.519887002378, 44853.0, 46022.76988615035, 46100.538994609626, 46464.767676161406, 47583.52416475791, 59128.704356477945, 60067.39932600618, 60390.39609603848, 60466.39533604783, 63770.0, 8623.784405389915, 8969.192772650493, 8974.551272436483, 9044.41211321262, 9292.674756383765, 10473.528691208761, 13795.379207935868, 13817.0, 13878.167309961435, 13894.583162505141, 12026.75946481048, 12268.938655306667, 12348.629541113782, 12556.183848049848, 12898.871011289766, 11956.70108247266, 11999.460024299102, 12090.818637720266, 12107.697307567028, 12283.508659653513, 9802.558884850056, 12406.62780116598, 12423.875761242634, 12489.625311240678, 12590.496380144692, 8918.509481978554, 8962.955185224033, 8964.68623598171, 9382.0, 9532.808398950132, 10562.419066951392, 12208.023358131151, 12257.69355766113, 12291.938540307241, 12308.446119924803], "value": 10381.597981769644, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1436.2603259321452, 1475.2918599072445, 1572.866306363959, 1689.9408520701777, 1699.5920978965053, 8401.159884011604, 9110.362274640778, 9113.772155696102, 9115.54422278885, 9118.544072796367, 7057.823554411142, 8416.957915210416, 8621.310295176387, 8673.0, 8959.73120806377, 2441.7314095449487, 2460.2373264288126, 2472.3942634054592, 2472.7279999200073, 2476.566600844854, 2405.0740464921046, 2454.355581760216, 2460.4463995601027, 2471.1845091119976, 2482.2056941778637, 2416.6495858100566, 2418.032786885251, 2430.744771798962, 2437.9512409751796, 2439.9756002439926, 2357.57563638545, 2364.7871691547757, 2369.732193276606, 2369.9763002370014, 2396.4607963208314, 2320.8027317678016, 2338.5206032763413, 2341.0869760793303, 2345.1088586337255, 2352.635341522067, 8937.46375217489, 9015.459072455673, 9016.278697704169, 9018.36871419001, 9018.954905225432, 5306.602004849613, 5477.67133971959, 5506.146547285177, 5508.14623733322, 5520.420355862657, 3580.427131658922, 3605.8016809075752, 3633.6729694327373, 3646.453032045188, 3676.889693309205, 1173.97065073373, 1175.9588414405541, 1182.8757980412106, 1217.9391030448442, 1225.9080568957363, 12528.874711252862, 12533.0, 12535.623931282076, 12535.874641253562, 12552.874471255353, 4684.906301873943, 4696.410928619622, 4735.573798358164, 4741.288806679026, 4936.432310284292, 10437.478126093665, 10445.634402795866, 10451.372917624967, 10560.419176945188, 10598.735031624272, 5392.433794451605, 5423.511883930465, 5424.294841670558, 5425.26758887553, 5426.375966763872, 3941.4087886817206, 4904.6321525885705, 4933.876653083702, 5003.399592048904, 5013.323201367769, 4032.354823228269, 4072.552019277877, 4092.529359123679, 4187.057911969782, 4218.514870789837, 1291.9289439080753, 1295.2163940815672, 1307.8888294495075, 1310.1091257944688, 1316.927568983715, 974.9171320437842, 1003.5383723487278, 1004.6132239088004, 1004.6433516101824, 1020.3826684855704, 6106.389361063858, 6201.224846894138, 6276.372362763687, 6464.903026454513, 6504.3495650435525, 434.758708916548, 439.5670115423742, 442.69896470400437, 446.19016485079476, 1035.1873779083535, 4001.8599349022643, 4238.766867822299, 4267.591694740728, 4293.97853010733, 4301.3117901135665, 10908.727281817859, 11359.716007099889, 11368.602098926498, 11370.658880233606, 11382.829257561143, 11289.15331350152, 11298.661040168809, 11307.830382544269, 11328.0, 11346.489407976496, 8316.916830831615, 8329.083800782031, 8443.184715286243, 8456.323494120456, 8481.618327175293, 6042.395760424099, 6157.784477543264, 6188.369942774213, 6201.0, 6215.906761398493, 9863.161631261422, 9981.750456238653, 10129.037741414553, 10210.795784084128, 10333.48332583383, 10149.543270552991, 10214.591416343263, 10389.220808439548, 10494.370337779757, 10508.211884108876, 6761.492888033319, 6966.895496567454, 6970.581765094111, 8052.83894322122, 8337.166283371856, 7678.923210768045, 8432.114627964222, 8695.0, 8728.039915609404, 9005.63977440895, 7915.525068495908, 7925.326347260548, 8105.27052565272, 8176.305014073871, 8199.754007379788, 7782.688692452239, 7787.92212077872, 7824.530528168328, 7849.411294152847, 7924.84150317002, 7068.151821781419, 7151.177614574182, 7152.821179470555, 7153.570785752871, 7156.355927966508, 5314.176302673091, 5388.973055134699, 5444.8366549003595, 5493.148561972901, 5671.17767923657, 5313.946860531345, 5486.533644640091, 5565.6104072714525, 5568.610197286151, 5593.4126916674795], "value": 4700.740780206293, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.14638379365033, 335.5872277099168, 341.1947803184485, 347.10447046619726, 349.7604141163302, 5194.168932970725, 5235.764390602418, 5239.318888544493, 5253.50091741284, 5293.920591191126, 5198.506141916521, 5215.374155101393, 5267.683938963665, 5290.6825590464505, 5291.761870715817, 3958.4062390641348, 3979.9602003980026, 4109.445224894645, 4151.107511884944, 4167.666586673074, 4144.896377590554, 4148.211839750437, 4151.854685086023, 4168.062186008155, 4172.499300083994, 4094.8566800162002, 4112.198121366319, 4114.773687447189, 4120.938185927213, 4127.422160897477, 3941.1920556286036, 3949.2693851637396, 4118.91762164758, 4146.087860670677, 4149.0, 3648.4709717090873, 3655.0, 3659.4327879178504, 3666.6883314918264, 3692.464592634053, 5126.231065340192, 5168.198929165986, 5175.197844334097, 5208.932168905403, 5218.0, 4499.662525310615, 4662.3705799716945, 4702.788374523155, 4710.858674239778, 4816.373871396731, 5514.834554963358, 5524.917126243109, 5537.390887002467, 5546.918350921572, 5553.16702494625, 3948.6841052715713, 3972.106276087886, 3979.6816254699556, 3980.442738016651, 3983.721139520235, 5555.777768889239, 5724.656520608777, 5767.394423585505, 5774.595778295479, 5792.68140252286, 4104.753714777123, 4113.449661210069, 4128.442660240889, 4128.483939507561, 4138.8344466221015, 4176.206520761046, 4178.662827895045, 4187.371894215831, 4190.20386126635, 4193.958060419418, 4551.1100451213715, 4658.34783130362, 4724.196886529298, 4730.905381892412, 4771.4512831024185, 5477.972610136924, 5497.615166938356, 5515.641483303572, 5550.111982082847, 5550.972245138829, 1395.7696979998389, 1432.8680342529285, 1433.1114708880352, 1440.0, 1441.373002743789, 858.043281740867, 907.5280853956037, 932.4871320773548, 940.6736501532806, 955.1403736636944, 5174.715390653475, 5310.2831117798605, 5356.250124982505, 5368.570514358842, 5371.301730775052, 5580.86047848807, 5627.577931655061, 5669.716514174274, 5751.1373294006235, 5754.223179870748, 5099.745012749348, 5357.678539287655, 5362.410134885159, 5369.476346117319, 5381.300430943952, 3002.1593953693, 3051.832149231769, 3053.0382929377174, 3056.724894759482, 3059.892903748358, 5917.0, 5930.657390330795, 5946.345901950782, 5964.135200395918, 5989.341172471025, 5630.40880707528, 5787.623804452782, 5820.35976042635, 5830.53355731549, 5847.94152058474, 5814.563907706939, 5868.413158684183, 5881.941180588225, 5891.587588868738, 5913.852153696192, 5404.594655400782, 5678.290213723285, 5688.459596338341, 5714.228579141929, 5720.6853623049465, 5679.687617180929, 5686.857828554319, 5702.714864256854, 5710.543156547549, 5710.857228569319, 5957.285125784933, 5964.359801054571, 5973.611715238496, 5973.641581505123, 5973.910391344047, 3970.265500882346, 4082.5509193989233, 4113.519133112137, 4113.609207125438, 4128.958710412858, 5723.0, 5738.942610573841, 5748.827535173951, 5748.942510575008, 5760.539156867357, 5417.6478528895495, 5625.718714064362, 5637.43625637433, 5654.943450565442, 5661.433856614306, 5545.390007099135, 5549.334079910436, 5559.777608895599, 5587.776488940397, 5601.691906945157, 5507.284053073236, 5516.172574113915, 5561.916571251515, 5573.108302671553, 5573.5819813513335, 5374.838754837361, 5414.538074719725, 5595.244641973444, 5602.719864006865, 5641.464060914206, 5438.809641662681, 5454.481824226692, 5474.91787623194, 5531.751071201886, 5538.224648549126], "value": 4246.4513638842045, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [763.7823220382193, 829.9577097921145, 840.743573210171, 850.2008112374367, 892.0, 13930.442782288708, 14846.331915063822, 14868.553943381703, 14878.776818347733, 14882.553523394303, 13736.587902362946, 14212.573622791308, 16186.433474828384, 16388.426405075825, 16471.34114635416, 798.1180795221284, 826.8801023851538, 832.6794184239081, 832.7376876283981, 833.7332053742805, 502.3318985748945, 794.0749027383121, 810.8743144812563, 812.8333691593209, 828.9253967142956, 848.321342925657, 851.8637018077109, 851.9914800852005, 852.9616167272457, 853.3130829682103, 847.7287268074218, 847.8007668197969, 849.2059923971045, 849.524266410812, 850.8128211793427, 381.7728451571311, 388.03766658686334, 392.27429255876683, 611.5963464113709, 625.3027873920591, 15505.379784808594, 15620.76568851468, 15623.453179138676, 15649.765253521206, 15658.68682626341, 13625.0, 13865.930670346685, 14036.438542458289, 14227.78658320126, 14512.78230826528, 13519.188848669111, 13630.795538066937, 13770.586882393543, 13842.861571384257, 13900.0, 4463.553644635511, 4482.305242687388, 4519.254323036695, 4539.432570928634, 4592.7933243004145, 80343.0, 81179.18820811716, 81316.15393461201, 82048.0, 83031.0, 11650.242734222249, 11717.824232636518, 11724.824127638092, 11821.290722556674, 12232.143749937419, 18503.629927401376, 18561.81438185628, 18567.0, 18577.349792757188, 18612.534686632942, 8096.959515202504, 8321.08468068512, 8456.0, 8548.145185481402, 8716.738497845075, 4523.479799823062, 4545.613622842029, 4563.840265590688, 4566.862994110182, 4683.859484215479, 3304.9173770655925, 3482.373172828915, 3483.303339332093, 3487.4245749451056, 3488.0, 581.8399940016444, 593.4747748242836, 596.6777939912399, 603.9456448919618, 608.850831546274, 587.4595372257534, 625.1716475669756, 671.4494114825893, 677.7593954146207, 678.2471456683078, 9511.0, 10037.69886903394, 10042.69871903844, 10151.695449136538, 10267.229957753198, 700.2927043685914, 701.551007355293, 702.2977022977022, 719.2735337309251, 723.5875550936021, 4520.547945205453, 4913.354026401124, 4955.306257124005, 4974.253861920669, 4975.328330675385, 76404.61797690977, 77970.47398601116, 93435.0, 124838.0, 128229.35885320514, 101038.0, 110797.0, 111358.0, 114221.0, 116202.41898790452, 67501.66249168722, 93958.0, 97954.0, 97977.51011244899, 98887.01112988777, 9259.953700231456, 9394.95302523483, 9532.714018579454, 9691.757706057122, 9704.854427183456, 55725.44274557203, 56982.430175697715, 57621.711891440274, 57798.13302800545, 58301.416985831296, 76123.61938190274, 81664.59167704123, 82975.585122074, 83663.0, 87505.0, 12372.566960156351, 12544.811827822408, 12617.179883307555, 12622.368881556069, 12871.806922896352, 12448.688782780502, 12641.3679316032, 13122.60632181036, 13385.0, 13552.186868787905, 12757.55348562796, 12784.959810001965, 12911.289879056741, 13439.932800335935, 13935.790963135358, 12750.936245318713, 12877.871221288042, 12937.870621293667, 13367.799483007568, 13803.585892423243, 11778.411079446165, 11892.227005244631, 12570.937145314581, 13192.142510736772, 13250.0, 10671.733206669895, 10756.070888199643, 10793.352398856094, 11099.445027748741, 11394.487248074023, 10182.134518566005, 10270.178385729274, 10285.74285642835, 10612.0, 10659.360438373722], "value": 7506.2595655225805, "unit": "score"}], "name": "dromaeo_css", "value": 7417.1899988856585, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 110.0, 113.0, 111.0, 109.0, 112.0, 111.0, 111.0, 113.0, 112.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 115.0, 122.0, 183.0, 124.0, 117.0, 145.0, 122.0, 155.0, 120.0], "value": 135.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 160.0, 160.0, 159.0, 161.0, 163.0, 160.0, 161.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 111.0, 76.0, 75.0, 75.0, 76.0, 120.0, 76.0], "value": 83.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 140.0, 86.0, 85.0, 86.0, 126.0, 85.0, 84.0, 131.0], "value": 99.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 118.0, 120.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 147.0, 145.0, 146.0, 147.0, 147.0, 146.0, 145.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 48.0, 52.0, 50.0, 50.0, 51.0, 50.0, 48.0, 52.0, 50.0], "value": 50.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 61.0, 61.0, 62.0, 62.0, 61.0, 61.0, 62.0, 62.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 77.0, 77.0, 81.0, 83.0, 78.0, 78.0, 76.0, 77.0], "value": 78.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 123.0, 123.0, 121.0, 124.0, 122.0, 125.0, 131.0, 152.0, 132.0], "value": 128.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 165.0, 161.0, 163.0, 161.0, 161.0, 166.0, 164.0, 160.0], "value": 163.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 69.0, 63.0, 65.0, 68.0, 64.0, 64.0, 64.0, 63.0, 69.0], "value": 65.2, "unit": "score"}], "name": "kraken", "value": 1493.8, "alertThreshold": 2.0}]} 06:14:27 INFO - Return code: 0 06:14:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:14:28 INFO - # TBPL SUCCESS # 06:14:28 INFO - Running post-action listener: _resource_record_post_action 06:14:28 INFO - [mozharness: 2016-08-13 13:14:28.007049Z] Finished run-tests step (success) 06:14:28 INFO - Running post-run listener: _resource_record_post_run 06:14:28 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 7782400; Write bytes: 456904704; Read time: 3060; Write time: 392352 06:14:28 INFO - TinderboxPrint: CPU usage
13.0% 06:14:28 INFO - TinderboxPrint: I/O read bytes / time
7,782,400 / 3,060 06:14:28 INFO - TinderboxPrint: I/O write bytes / time
456,904,704 / 392,352 06:14:28 INFO - TinderboxPrint: CPU idle
8,294.6 (87.0%) 06:14:28 INFO - TinderboxPrint: CPU user
1,194.6 (12.5%) 06:14:28 INFO - TinderboxPrint: Swap in / out
0 / 0 06:14:28 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 95092736; Read time: 0; Write time: 91484 06:14:28 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 5545984; Write bytes: 361811968; Read time: 2916; Write time: 300868 06:14:28 INFO - Running post-run listener: _upload_blobber_files 06:14:28 INFO - Blob upload gear active. 06:14:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:14:28 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 06:14:28 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:14:28 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:14:29 INFO - (blobuploader) - INFO - Open directory for files ... 06:14:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:14:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:14:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:14:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:14:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:14:30 INFO - (blobuploader) - INFO - Done attempting. 06:14:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:14:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:14:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:14:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:14:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:14:33 INFO - (blobuploader) - INFO - Done attempting. 06:14:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:14:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:14:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:14:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:14:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:14:34 INFO - (blobuploader) - INFO - Done attempting. 06:14:34 INFO - (blobuploader) - INFO - Iteration through files over. 06:14:34 INFO - Return code: 0 06:14:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:14:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:14:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dfb61c03b0be0ff1f33f9fabd1d3572f057e78ae417c4d09ef85944d8a8e90c0d3794962e0e9b05f262f9ab8bcdbfad42e34bf3fa4a4d410c836d1c97bcb05ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6735d77390433f51034879c8d5d368a5c33267c9331cf9755d57c304556a74c579394e12339f4cc1e579bf6920f567153b717304bff6c9e39137b3eeb87eec9e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fab505aad237ff7dffbe4fe532649a8ecdd88bf9c04e8fb48834befa7f54c433b2b0ab9409771b2b8f7c15cb03d24ff68d96f878718b9c1a85f1bbc4eeaea8ba"} 06:14:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:14:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:14:34 INFO - Contents: 06:14:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dfb61c03b0be0ff1f33f9fabd1d3572f057e78ae417c4d09ef85944d8a8e90c0d3794962e0e9b05f262f9ab8bcdbfad42e34bf3fa4a4d410c836d1c97bcb05ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6735d77390433f51034879c8d5d368a5c33267c9331cf9755d57c304556a74c579394e12339f4cc1e579bf6920f567153b717304bff6c9e39137b3eeb87eec9e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fab505aad237ff7dffbe4fe532649a8ecdd88bf9c04e8fb48834befa7f54c433b2b0ab9409771b2b8f7c15cb03d24ff68d96f878718b9c1a85f1bbc4eeaea8ba"} 06:14:34 INFO - Running post-run listener: copy_logs_to_upload_dir 06:14:34 INFO - Copying logs to upload dir... 06:14:34 INFO - mkdir: /builds/slave/test/build/upload/logs 06:14:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.321024 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-08-13 06:14:34.131945) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-13 06:14:34.137661) ========= 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=232498196343f89f466a4a9a000001c8-1471090073.365106-58454676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dfb61c03b0be0ff1f33f9fabd1d3572f057e78ae417c4d09ef85944d8a8e90c0d3794962e0e9b05f262f9ab8bcdbfad42e34bf3fa4a4d410c836d1c97bcb05ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6735d77390433f51034879c8d5d368a5c33267c9331cf9755d57c304556a74c579394e12339f4cc1e579bf6920f567153b717304bff6c9e39137b3eeb87eec9e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fab505aad237ff7dffbe4fe532649a8ecdd88bf9c04e8fb48834befa7f54c433b2b0ab9409771b2b8f7c15cb03d24ff68d96f878718b9c1a85f1bbc4eeaea8ba"} build_url:https://queue.taskcluster.net/v1/task/Q-eHDxP1RN---wLJphfvqA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011331 build_url: 'https://queue.taskcluster.net/v1/task/Q-eHDxP1RN---wLJphfvqA/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/Firefox/sha512/dfb61c03b0be0ff1f33f9fabd1d3572f057e78ae417c4d09ef85944d8a8e90c0d3794962e0e9b05f262f9ab8bcdbfad42e34bf3fa4a4d410c836d1c97bcb05ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6735d77390433f51034879c8d5d368a5c33267c9331cf9755d57c304556a74c579394e12339f4cc1e579bf6920f567153b717304bff6c9e39137b3eeb87eec9e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fab505aad237ff7dffbe4fe532649a8ecdd88bf9c04e8fb48834befa7f54c433b2b0ab9409771b2b8f7c15cb03d24ff68d96f878718b9c1a85f1bbc4eeaea8ba"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-13 06:14:34.163068) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 06:14:34.163438) ========= 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=232498196343f89f466a4a9a000001c8-1471090073.365106-58454676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004465 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 06:14:34.247356) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-13 06:14:34.247723) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-13 06:14:34.248088) ========= ========= Total master_lag: 0.18 =========