builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-057 starttime: 1470876568.17 results: success (0) buildid: 20160810163021 builduid: 451c5c7ac5df4d0e9749fc5842865b1e revision: dc8f8117d67b5ae9c7b42b72e3567ef5e754b1fa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-10 17:49:28.170826) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-10 17:49:28.171236) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-10 17:49:28.171526) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-10 17:49:28.213369) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 17:49:28.213646) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1470876422.207024-630820636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-10 17:49:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2016-08-10 17:49:28 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.072796 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 17:49:28.303854) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 17:49:28.304132) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1470876422.207024-630820636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018190 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 17:49:28.352843) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 17:49:28.353184) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev dc8f8117d67b5ae9c7b42b72e3567ef5e754b1fa --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 dc8f8117d67b5ae9c7b42b72e3567ef5e754b1fa --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=934fc3100db09dcb9af4d4b6000001ab-1470876422.207024-630820636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-10 17:49:28,548 truncating revision to first 12 chars 2016-08-10 17:49:28,548 Setting DEBUG logging. 2016-08-10 17:49:28,548 attempt 1/10 2016-08-10 17:49:28,548 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/dc8f8117d67b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-10 17:49:28,859 unpacking tar archive at: mozilla-central-dc8f8117d67b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.642388 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 17:49:29.009195) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-10 17:49:29.009508) ========= script_repo_revision: dc8f8117d67b5ae9c7b42b72e3567ef5e754b1fa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-10 17:49:29.009895) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-10 17:49:29.010164) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-10 17:49:29.023037) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-08-10 17:49:29.023350) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=934fc3100db09dcb9af4d4b6000001ab-1470876422.207024-630820636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:49:29 INFO - MultiFileLogger online at 20160810 17:49:29 in /builds/slave/test 17:49:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 17:49:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:49:29 INFO - {'append_to_log': False, 17:49:29 INFO - 'base_work_dir': '/builds/slave/test', 17:49:29 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:49:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:49:29 INFO - 'branch': 'Firefox-Non-PGO', 17:49:29 INFO - 'buildbot_json_path': 'buildprops.json', 17:49:29 INFO - 'config_files': ('talos/linux_config.py',), 17:49:29 INFO - 'default_actions': ('clobber', 17:49:29 INFO - 'read-buildbot-config', 17:49:29 INFO - 'download-and-extract', 17:49:29 INFO - 'populate-webroot', 17:49:29 INFO - 'create-virtualenv', 17:49:29 INFO - 'install', 17:49:29 INFO - 'run-tests'), 17:49:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:49:29 INFO - 'download_minidump_stackwalk': True, 17:49:29 INFO - 'download_symbols': 'ondemand', 17:49:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:49:29 INFO - 'tooltool.py': '/tools/tooltool.py', 17:49:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:49:29 INFO - '/tools/misc-python/virtualenv.py')}, 17:49:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:49:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:49:29 INFO - 'installer_path': 'installer.exe', 17:49:29 INFO - 'log_level': 'info', 17:49:29 INFO - 'log_name': 'talos', 17:49:29 INFO - 'log_to_console': True, 17:49:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:49:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:49:29 INFO - 'opt_config_files': (), 17:49:29 INFO - 'pip_index': False, 17:49:29 INFO - 'sps_profile': False, 17:49:29 INFO - 'sps_profile_interval': 0, 17:49:29 INFO - 'suite': 'dromaeojs', 17:49:29 INFO - 'system_bits': '32', 17:49:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:49:29 INFO - 'title': 'talos-linux64-ix-057', 17:49:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:49:29 INFO - 'use_talos_json': True, 17:49:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:49:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:49:29 INFO - 'work_dir': 'build'} 17:49:29 INFO - [mozharness: 2016-08-11 00:49:29.309606Z] Running clobber step. 17:49:29 INFO - Running pre-action listener: _resource_record_pre_action 17:49:29 INFO - Running main action method: clobber 17:49:29 INFO - rmtree: /builds/slave/test/build 17:49:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:49:29 INFO - Running post-action listener: _resource_record_post_action 17:49:29 INFO - [mozharness: 2016-08-11 00:49:29.764232Z] Finished clobber step (success) 17:49:29 INFO - [mozharness: 2016-08-11 00:49:29.764333Z] Running read-buildbot-config step. 17:49:29 INFO - Running pre-action listener: _resource_record_pre_action 17:49:29 INFO - Running main action method: read_buildbot_config 17:49:29 INFO - Using buildbot properties: 17:49:29 INFO - { 17:49:29 INFO - "project": "", 17:49:29 INFO - "product": "firefox", 17:49:29 INFO - "script_repo_revision": "production", 17:49:29 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 17:49:29 INFO - "repository": "", 17:49:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 17:49:29 INFO - "buildid": "20160810163021", 17:49:29 INFO - "pgo_build": "False", 17:49:29 INFO - "basedir": "/builds/slave/test", 17:49:29 INFO - "buildnumber": 675, 17:49:29 INFO - "slavename": "talos-linux64-ix-057", 17:49:29 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:49:29 INFO - "platform": "ubuntu64_hw", 17:49:29 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 17:49:29 INFO - "branch": "mozilla-central", 17:49:29 INFO - "repo_path": "mozilla-central", 17:49:29 INFO - "revision": "dc8f8117d67b5ae9c7b42b72e3567ef5e754b1fa", 17:49:29 INFO - "stage_platform": "linux64", 17:49:29 INFO - "builduid": "451c5c7ac5df4d0e9749fc5842865b1e", 17:49:29 INFO - "slavebuilddir": "test" 17:49:29 INFO - } 17:49:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/Li5VGSHDR5GlxAyDGycIcA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 17:49:29 INFO - Running post-action listener: _resource_record_post_action 17:49:29 INFO - [mozharness: 2016-08-11 00:49:29.767228Z] Finished read-buildbot-config step (success) 17:49:29 INFO - [mozharness: 2016-08-11 00:49:29.767317Z] Running download-and-extract step. 17:49:29 INFO - Running pre-action listener: _resource_record_pre_action 17:49:29 INFO - Running main action method: download_and_extract 17:49:29 INFO - mkdir: /builds/slave/test/build/tests 17:49:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:49:29 INFO - trying https://queue.taskcluster.net/v1/task/Li5VGSHDR5GlxAyDGycIcA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 17:49:29 INFO - Downloading https://queue.taskcluster.net/v1/task/Li5VGSHDR5GlxAyDGycIcA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 17:49:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Li5VGSHDR5GlxAyDGycIcA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:49:30 INFO - Downloaded 1361 bytes. 17:49:30 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 17:49:30 INFO - Using the following test package requirements: 17:49:30 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 17:49:30 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:49:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:49:30 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:49:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:49:30 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:49:30 INFO - u'jsshell-linux-x86_64.zip'], 17:49:30 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:49:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:49:30 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 17:49:30 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:49:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:49:30 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:49:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:49:30 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:49:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:49:30 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:49:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:49:30 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:49:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:49:30 INFO - trying https://queue.taskcluster.net/v1/task/Li5VGSHDR5GlxAyDGycIcA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:49:30 INFO - Downloading https://queue.taskcluster.net/v1/task/Li5VGSHDR5GlxAyDGycIcA/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 17:49:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Li5VGSHDR5GlxAyDGycIcA/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 17:49:31 INFO - Downloaded 20262077 bytes. 17:49:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:49:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:49:32 INFO - Return code: 0 17:49:32 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:49:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:49:32 INFO - trying https://queue.taskcluster.net/v1/task/Li5VGSHDR5GlxAyDGycIcA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:49:32 INFO - Downloading https://queue.taskcluster.net/v1/task/Li5VGSHDR5GlxAyDGycIcA/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 17:49:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Li5VGSHDR5GlxAyDGycIcA/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 17:49:33 INFO - Downloaded 20262077 bytes. 17:49:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:49:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:49:34 INFO - Return code: 0 17:49:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:49:34 INFO - trying https://queue.taskcluster.net/v1/task/Li5VGSHDR5GlxAyDGycIcA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 17:49:34 INFO - Downloading https://queue.taskcluster.net/v1/task/Li5VGSHDR5GlxAyDGycIcA/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 17:49:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Li5VGSHDR5GlxAyDGycIcA/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 17:49:35 INFO - Downloaded 14413719 bytes. 17:49:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:49:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:49:36 INFO - Return code: 0 17:49:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:49:36 INFO - trying https://queue.taskcluster.net/v1/task/Li5VGSHDR5GlxAyDGycIcA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:49:36 INFO - Downloading https://queue.taskcluster.net/v1/task/Li5VGSHDR5GlxAyDGycIcA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:49:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Li5VGSHDR5GlxAyDGycIcA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:49:37 INFO - Downloaded 55610888 bytes. 17:49:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Li5VGSHDR5GlxAyDGycIcA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:49:37 INFO - mkdir: /builds/slave/test/properties 17:49:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:49:37 INFO - Writing to file /builds/slave/test/properties/build_url 17:49:37 INFO - Contents: 17:49:37 INFO - build_url:https://queue.taskcluster.net/v1/task/Li5VGSHDR5GlxAyDGycIcA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:49:38 INFO - Running post-action listener: _resource_record_post_action 17:49:38 INFO - Running post-action listener: set_extra_try_arguments 17:49:38 INFO - [mozharness: 2016-08-11 00:49:38.461713Z] Finished download-and-extract step (success) 17:49:38 INFO - [mozharness: 2016-08-11 00:49:38.462039Z] Running populate-webroot step. 17:49:38 INFO - Running pre-action listener: _resource_record_pre_action 17:49:38 INFO - Running main action method: populate_webroot 17:49:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:49:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:49:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:49:38 INFO - '--tppagecycles', 17:49:38 INFO - '7'], 17:49:38 INFO - 'tests': ['tsvgm']}}, 17:49:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:49:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:49:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:49:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:49:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:49:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:49:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:49:38 INFO - 'talos_options': ['--disable-e10s'], 17:49:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:49:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:49:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:49:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:49:38 INFO - 'talos_options': ['--disable-e10s'], 17:49:38 INFO - 'tests': ['damp', 'tps']}, 17:49:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:49:38 INFO - 'tests': ['damp', 'tps']}, 17:49:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:49:38 INFO - 'tests': ['dromaeo_dom']}, 17:49:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:49:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:49:38 INFO - 'tests': ['basic_compositor_video']}, 17:49:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:49:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:49:38 INFO - 'tests': ['a11yr', 17:49:38 INFO - 'ts_paint', 17:49:38 INFO - 'tpaint', 17:49:38 INFO - 'sessionrestore', 17:49:38 INFO - 'sessionrestore_no_auto_restore', 17:49:38 INFO - 'tabpaint']}, 17:49:38 INFO - 'other-e10s': {'tests': ['a11yr', 17:49:38 INFO - 'ts_paint', 17:49:38 INFO - 'tpaint', 17:49:38 INFO - 'sessionrestore', 17:49:38 INFO - 'sessionrestore_no_auto_restore', 17:49:38 INFO - 'tabpaint']}, 17:49:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:49:38 INFO - 'ts_paint', 17:49:38 INFO - 'tpaint', 17:49:38 INFO - 'sessionrestore', 17:49:38 INFO - 'sessionrestore_no_auto_restore', 17:49:38 INFO - 'tabpaint']}, 17:49:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:49:38 INFO - 'ts_paint', 17:49:38 INFO - 'tpaint', 17:49:38 INFO - 'sessionrestore', 17:49:38 INFO - 'sessionrestore_no_auto_restore', 17:49:38 INFO - 'tabpaint']}, 17:49:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:49:38 INFO - 'tests': ['a11yr', 17:49:38 INFO - 'ts_paint', 17:49:38 INFO - 'tpaint', 17:49:38 INFO - 'sessionrestore', 17:49:38 INFO - 'sessionrestore_no_auto_restore', 17:49:38 INFO - 'tabpaint']}, 17:49:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:49:38 INFO - 'tests': ['a11yr', 17:49:38 INFO - 'ts_paint', 17:49:38 INFO - 'tpaint', 17:49:38 INFO - 'sessionrestore', 17:49:38 INFO - 'sessionrestore_no_auto_restore', 17:49:38 INFO - 'tabpaint']}, 17:49:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:49:38 INFO - 'tests': ['tsvgx', 17:49:38 INFO - 'tsvgr_opacity', 17:49:38 INFO - 'tart', 17:49:38 INFO - 'tscrollx', 17:49:38 INFO - 'cart']}, 17:49:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:49:38 INFO - 'tsvgr_opacity', 17:49:38 INFO - 'tart', 17:49:38 INFO - 'tscrollx', 17:49:38 INFO - 'cart']}, 17:49:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:49:38 INFO - 'talos_options': ['--disable-e10s'], 17:49:38 INFO - 'tests': ['tp5o']}, 17:49:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:49:38 INFO - 'tests': ['tp5o']}, 17:49:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:49:38 INFO - 'talos_options': ['--disable-e10s', 17:49:38 INFO - '--xperf_path', 17:49:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:49:38 INFO - 'tests': ['tp5n']}, 17:49:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:49:38 INFO - 'talos_options': ['--xperf_path', 17:49:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:49:38 INFO - 'tests': ['tp5n']}}, 17:49:38 INFO - 'talos.zip': {'path': '', 17:49:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:49:38 INFO - Running post-action listener: _resource_record_post_action 17:49:38 INFO - [mozharness: 2016-08-11 00:49:38.483334Z] Finished populate-webroot step (success) 17:49:38 INFO - [mozharness: 2016-08-11 00:49:38.483423Z] Running create-virtualenv step. 17:49:38 INFO - Running pre-action listener: _resource_record_pre_action 17:49:38 INFO - Running main action method: create_virtualenv 17:49:38 INFO - Creating virtualenv /builds/slave/test/build/venv 17:49:38 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:49:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:49:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:49:38 INFO - Using real prefix '/usr' 17:49:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:49:39 INFO - Installing distribute.............................................................................................................................................................................................done. 17:49:41 INFO - Installing pip.................done. 17:49:41 INFO - Return code: 0 17:49:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:49:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:49:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:49:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:41 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 0x14cd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178c3b0>, '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 0x178d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178d740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470876422.207024-630820636', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:49:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:49:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:49:41 INFO - Using env: {'DISPLAY': ':0', 17:49:41 INFO - 'HOME': '/home/cltbld', 17:49:41 INFO - 'LANG': 'en_US.UTF-8', 17:49:41 INFO - 'LANGUAGE': 'en_US:en', 17:49:41 INFO - 'LOGNAME': 'cltbld', 17:49:41 INFO - 'MAIL': '/var/mail/cltbld', 17:49:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:41 INFO - 'MOZ_NO_REMOTE': '1', 17:49:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:41 INFO - 'NO_EM_RESTART': '1', 17:49:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:41 INFO - 'PWD': '/builds/slave/test', 17:49:41 INFO - 'SHELL': '/bin/bash', 17:49:41 INFO - 'SHLVL': '1', 17:49:41 INFO - 'TERM': 'linux', 17:49:41 INFO - 'TMOUT': '86400', 17:49:41 INFO - 'USER': 'cltbld', 17:49:41 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470876422.207024-630820636', 17:49:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:41 INFO - '_': '/tools/buildbot/bin/python'} 17:49:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:41 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:49:41 INFO - Cleaning up... 17:49:41 INFO - Return code: 0 17:49:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:49:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:49:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:49:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:41 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 0x14cd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178c3b0>, '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 0x178d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178d740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470876422.207024-630820636', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:49:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:49:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:49:41 INFO - Using env: {'DISPLAY': ':0', 17:49:41 INFO - 'HOME': '/home/cltbld', 17:49:41 INFO - 'LANG': 'en_US.UTF-8', 17:49:41 INFO - 'LANGUAGE': 'en_US:en', 17:49:41 INFO - 'LOGNAME': 'cltbld', 17:49:41 INFO - 'MAIL': '/var/mail/cltbld', 17:49:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:41 INFO - 'MOZ_NO_REMOTE': '1', 17:49:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:41 INFO - 'NO_EM_RESTART': '1', 17:49:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:41 INFO - 'PWD': '/builds/slave/test', 17:49:41 INFO - 'SHELL': '/bin/bash', 17:49:41 INFO - 'SHLVL': '1', 17:49:41 INFO - 'TERM': 'linux', 17:49:41 INFO - 'TMOUT': '86400', 17:49:41 INFO - 'USER': 'cltbld', 17:49:41 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470876422.207024-630820636', 17:49:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:41 INFO - '_': '/tools/buildbot/bin/python'} 17:49:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:41 INFO - Downloading/unpacking psutil>=3.1.1 17:49:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:49:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:49:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:49:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:49:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:49:43 INFO - Installing collected packages: psutil 17:49:43 INFO - Running setup.py install for psutil 17:49:43 INFO - building 'psutil._psutil_linux' extension 17:49:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:49:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:49:43 INFO - building 'psutil._psutil_posix' extension 17:49:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:49:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:49:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:49:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:49:43 INFO - Successfully installed psutil 17:49:43 INFO - Cleaning up... 17:49:44 INFO - Return code: 0 17:49:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:49:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:49:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:44 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 0x14cd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178c3b0>, '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 0x178d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178d740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470876422.207024-630820636', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:49:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:49:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:49:44 INFO - Using env: {'DISPLAY': ':0', 17:49:44 INFO - 'HOME': '/home/cltbld', 17:49:44 INFO - 'LANG': 'en_US.UTF-8', 17:49:44 INFO - 'LANGUAGE': 'en_US:en', 17:49:44 INFO - 'LOGNAME': 'cltbld', 17:49:44 INFO - 'MAIL': '/var/mail/cltbld', 17:49:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:44 INFO - 'MOZ_NO_REMOTE': '1', 17:49:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:44 INFO - 'NO_EM_RESTART': '1', 17:49:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:44 INFO - 'PWD': '/builds/slave/test', 17:49:44 INFO - 'SHELL': '/bin/bash', 17:49:44 INFO - 'SHLVL': '1', 17:49:44 INFO - 'TERM': 'linux', 17:49:44 INFO - 'TMOUT': '86400', 17:49:44 INFO - 'USER': 'cltbld', 17:49:44 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470876422.207024-630820636', 17:49:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:44 INFO - '_': '/tools/buildbot/bin/python'} 17:49:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:49:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:49:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:49:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:49:46 INFO - Installing collected packages: mozsystemmonitor 17:49:46 INFO - Running setup.py install for mozsystemmonitor 17:49:46 INFO - Successfully installed mozsystemmonitor 17:49:46 INFO - Cleaning up... 17:49:46 INFO - Return code: 0 17:49:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:49:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:49:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x14cd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178c3b0>, '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 0x178d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178d740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470876422.207024-630820636', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:49:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:49:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:49:46 INFO - Using env: {'DISPLAY': ':0', 17:49:46 INFO - 'HOME': '/home/cltbld', 17:49:46 INFO - 'LANG': 'en_US.UTF-8', 17:49:46 INFO - 'LANGUAGE': 'en_US:en', 17:49:46 INFO - 'LOGNAME': 'cltbld', 17:49:46 INFO - 'MAIL': '/var/mail/cltbld', 17:49:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:46 INFO - 'MOZ_NO_REMOTE': '1', 17:49:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:46 INFO - 'NO_EM_RESTART': '1', 17:49:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:46 INFO - 'PWD': '/builds/slave/test', 17:49:46 INFO - 'SHELL': '/bin/bash', 17:49:46 INFO - 'SHLVL': '1', 17:49:46 INFO - 'TERM': 'linux', 17:49:46 INFO - 'TMOUT': '86400', 17:49:46 INFO - 'USER': 'cltbld', 17:49:46 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470876422.207024-630820636', 17:49:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:46 INFO - '_': '/tools/buildbot/bin/python'} 17:49:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:46 INFO - Downloading/unpacking jsonschema==2.5.1 17:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:49:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:49:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:49:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:49:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:49:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:48 INFO - Downloading functools32-3.2.3-2.tar.gz 17:49:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:49:48 INFO - warning: no files found matching '*.txt' 17:49:48 INFO - no previously-included directories found matching 'build' 17:49:48 INFO - no previously-included directories found matching 'dist' 17:49:48 INFO - no previously-included directories found matching '.git*' 17:49:48 INFO - Installing collected packages: jsonschema, functools32 17:49:48 INFO - Running setup.py install for functools32 17:49:48 INFO - warning: no files found matching '*.txt' 17:49:48 INFO - no previously-included directories found matching 'build' 17:49:48 INFO - no previously-included directories found matching 'dist' 17:49:48 INFO - no previously-included directories found matching '.git*' 17:49:48 INFO - Successfully installed jsonschema functools32 17:49:48 INFO - Cleaning up... 17:49:48 INFO - Return code: 0 17:49:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:49:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:49:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:49:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x14cd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178c3b0>, '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 0x178d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178d740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470876422.207024-630820636', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:49:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:49:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:49:48 INFO - Using env: {'DISPLAY': ':0', 17:49:48 INFO - 'HOME': '/home/cltbld', 17:49:48 INFO - 'LANG': 'en_US.UTF-8', 17:49:48 INFO - 'LANGUAGE': 'en_US:en', 17:49:48 INFO - 'LOGNAME': 'cltbld', 17:49:48 INFO - 'MAIL': '/var/mail/cltbld', 17:49:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:48 INFO - 'MOZ_NO_REMOTE': '1', 17:49:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:48 INFO - 'NO_EM_RESTART': '1', 17:49:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:48 INFO - 'PWD': '/builds/slave/test', 17:49:48 INFO - 'SHELL': '/bin/bash', 17:49:48 INFO - 'SHLVL': '1', 17:49:48 INFO - 'TERM': 'linux', 17:49:48 INFO - 'TMOUT': '86400', 17:49:48 INFO - 'USER': 'cltbld', 17:49:48 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470876422.207024-630820636', 17:49:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:48 INFO - '_': '/tools/buildbot/bin/python'} 17:49:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:49:49 INFO - Cleaning up... 17:49:49 INFO - Return code: 0 17:49:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:49: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')]} 17:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49: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')]} 17:49:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:49 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 0x14cd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178c3b0>, '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 0x178d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178d740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470876422.207024-630820636', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:49:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:49:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:49:49 INFO - Using env: {'DISPLAY': ':0', 17:49:49 INFO - 'HOME': '/home/cltbld', 17:49:49 INFO - 'LANG': 'en_US.UTF-8', 17:49:49 INFO - 'LANGUAGE': 'en_US:en', 17:49:49 INFO - 'LOGNAME': 'cltbld', 17:49:49 INFO - 'MAIL': '/var/mail/cltbld', 17:49:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:49 INFO - 'MOZ_NO_REMOTE': '1', 17:49:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:49 INFO - 'NO_EM_RESTART': '1', 17:49:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:49 INFO - 'PWD': '/builds/slave/test', 17:49:49 INFO - 'SHELL': '/bin/bash', 17:49:49 INFO - 'SHLVL': '1', 17:49:49 INFO - 'TERM': 'linux', 17:49:49 INFO - 'TMOUT': '86400', 17:49:49 INFO - 'USER': 'cltbld', 17:49:49 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470876422.207024-630820636', 17:49:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:49 INFO - '_': '/tools/buildbot/bin/python'} 17:49:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:49 INFO - Downloading/unpacking blobuploader==1.2.4 17:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:49:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:51 INFO - Downloading blobuploader-1.2.4.tar.gz 17:49:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:49:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:49:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:49:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:49:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:52 INFO - Downloading docopt-0.6.1.tar.gz 17:49:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:49:52 INFO - Installing collected packages: blobuploader, requests, docopt 17:49:52 INFO - Running setup.py install for blobuploader 17:49:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:49:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:49:52 INFO - Running setup.py install for requests 17:49:52 INFO - Running setup.py install for docopt 17:49:52 INFO - Successfully installed blobuploader requests docopt 17:49:52 INFO - Cleaning up... 17:49:52 INFO - Return code: 0 17:49:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:49:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:49:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:52 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 0x14cd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178c3b0>, '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 0x178d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178d740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470876422.207024-630820636', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:49:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:49:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:49:52 INFO - Using env: {'DISPLAY': ':0', 17:49:52 INFO - 'HOME': '/home/cltbld', 17:49:52 INFO - 'LANG': 'en_US.UTF-8', 17:49:52 INFO - 'LANGUAGE': 'en_US:en', 17:49:52 INFO - 'LOGNAME': 'cltbld', 17:49:52 INFO - 'MAIL': '/var/mail/cltbld', 17:49:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:52 INFO - 'MOZ_NO_REMOTE': '1', 17:49:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:52 INFO - 'NO_EM_RESTART': '1', 17:49:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:52 INFO - 'PWD': '/builds/slave/test', 17:49:52 INFO - 'SHELL': '/bin/bash', 17:49:52 INFO - 'SHLVL': '1', 17:49:52 INFO - 'TERM': 'linux', 17:49:52 INFO - 'TMOUT': '86400', 17:49:52 INFO - 'USER': 'cltbld', 17:49:52 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470876422.207024-630820636', 17:49:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:52 INFO - '_': '/tools/buildbot/bin/python'} 17:49:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:49:52 INFO - Running setup.py (path:/tmp/pip-Apkjq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:49:53 INFO - Running setup.py (path:/tmp/pip-yD54er-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:49:53 INFO - Running setup.py (path:/tmp/pip-Xo08XH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:49:53 INFO - Running setup.py (path:/tmp/pip-PQtcQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:49:53 INFO - Running setup.py (path:/tmp/pip-bjYJCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:49:53 INFO - Running setup.py (path:/tmp/pip-3nYaTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:49:53 INFO - Running setup.py (path:/tmp/pip-tO8HRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:49:53 INFO - Running setup.py (path:/tmp/pip-Phe9TR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:49:53 INFO - Running setup.py (path:/tmp/pip-Yz7cND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:49:53 INFO - Running setup.py (path:/tmp/pip-jq65gF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:49:53 INFO - Running setup.py (path:/tmp/pip-PiwiPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:49:53 INFO - Running setup.py (path:/tmp/pip-vpds3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:49:53 INFO - Running setup.py (path:/tmp/pip-tGT8l9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:49:53 INFO - Running setup.py (path:/tmp/pip-ebv5Jb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:49:54 INFO - Running setup.py (path:/tmp/pip-6cqSti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:49:54 INFO - Running setup.py (path:/tmp/pip-3_MNxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:49:54 INFO - Running setup.py (path:/tmp/pip-cToaG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:49:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:49:54 INFO - Running setup.py install for manifestparser 17:49:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:49:54 INFO - Running setup.py install for mozcrash 17:49:54 INFO - Running setup.py install for mozdebug 17:49:54 INFO - Running setup.py install for mozdevice 17:49:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:49:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:49:54 INFO - Running setup.py install for mozfile 17:49:54 INFO - Running setup.py install for mozhttpd 17:49:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:49:54 INFO - Running setup.py install for mozinfo 17:49:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:49:54 INFO - Running setup.py install for mozInstall 17:49:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:49:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:49:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:49:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:49:55 INFO - Running setup.py install for mozleak 17:49:55 INFO - Running setup.py install for mozlog 17:49:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:49:55 INFO - Running setup.py install for moznetwork 17:49:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:49:55 INFO - Running setup.py install for mozprocess 17:49:55 INFO - Running setup.py install for mozprofile 17:49:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:49:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:49:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:49:55 INFO - Running setup.py install for mozrunner 17:49:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:49:55 INFO - Running setup.py install for mozscreenshot 17:49:55 INFO - Running setup.py install for moztest 17:49:55 INFO - Running setup.py install for mozversion 17:49:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:49:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:49:56 INFO - Cleaning up... 17:49:56 INFO - Return code: 0 17:49:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:49:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:49:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:56 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 0x14cd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178c3b0>, '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 0x178d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178d740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470876422.207024-630820636', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:49:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:49:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:49:56 INFO - Using env: {'DISPLAY': ':0', 17:49:56 INFO - 'HOME': '/home/cltbld', 17:49:56 INFO - 'LANG': 'en_US.UTF-8', 17:49:56 INFO - 'LANGUAGE': 'en_US:en', 17:49:56 INFO - 'LOGNAME': 'cltbld', 17:49:56 INFO - 'MAIL': '/var/mail/cltbld', 17:49:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:56 INFO - 'MOZ_NO_REMOTE': '1', 17:49:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:56 INFO - 'NO_EM_RESTART': '1', 17:49:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:56 INFO - 'PWD': '/builds/slave/test', 17:49:56 INFO - 'SHELL': '/bin/bash', 17:49:56 INFO - 'SHLVL': '1', 17:49:56 INFO - 'TERM': 'linux', 17:49:56 INFO - 'TMOUT': '86400', 17:49:56 INFO - 'USER': 'cltbld', 17:49:56 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470876422.207024-630820636', 17:49:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:56 INFO - '_': '/tools/buildbot/bin/python'} 17:49:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:49:56 INFO - Running setup.py (path:/tmp/pip-UWMj8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:49:56 INFO - Running setup.py (path:/tmp/pip-NV7GEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:49:56 INFO - Running setup.py (path:/tmp/pip-0cCI7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:49:56 INFO - Running setup.py (path:/tmp/pip-4dNAOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:49:56 INFO - Running setup.py (path:/tmp/pip-Eg4RWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:49:56 INFO - Running setup.py (path:/tmp/pip-MeIgMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:49:56 INFO - Running setup.py (path:/tmp/pip-SQcGqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:49:56 INFO - Running setup.py (path:/tmp/pip-fkSGzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:49:56 INFO - Running setup.py (path:/tmp/pip-HIOCvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:49:56 INFO - Running setup.py (path:/tmp/pip-sVX92V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:49:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:49:57 INFO - Running setup.py (path:/tmp/pip-371YYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:49:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:49:57 INFO - Running setup.py (path:/tmp/pip-yJ5h44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:49:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:49:57 INFO - Running setup.py (path:/tmp/pip-hToYKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:49:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:49:57 INFO - Running setup.py (path:/tmp/pip-Jj7A_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:49:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:49:57 INFO - Running setup.py (path:/tmp/pip-HYOMWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:49:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:49:57 INFO - Running setup.py (path:/tmp/pip-z23jeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:49:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:49:57 INFO - Running setup.py (path:/tmp/pip-QeRaJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:49:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:49:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:49:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:49:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:49:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:49:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:49:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:49:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:59 INFO - Downloading blessings-1.6.tar.gz 17:49:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:49:59 INFO - Installing collected packages: blessings 17:49:59 INFO - Running setup.py install for blessings 17:49:59 INFO - Successfully installed blessings 17:49:59 INFO - Cleaning up... 17:49:59 INFO - Return code: 0 17:49:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:49:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:49:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:49:59 INFO - Reading from file tmpfile_stdout 17:49:59 INFO - Current package versions: 17:49:59 INFO - argparse == 1.2.1 17:49:59 INFO - blessings == 1.6 17:49:59 INFO - blobuploader == 1.2.4 17:49:59 INFO - docopt == 0.6.1 17:49:59 INFO - functools32 == 3.2.3-2 17:49:59 INFO - jsonschema == 2.5.1 17:49:59 INFO - manifestparser == 1.1 17:49:59 INFO - mozInstall == 1.12 17:49:59 INFO - mozcrash == 0.17 17:49:59 INFO - mozdebug == 0.1 17:49:59 INFO - mozdevice == 0.48 17:49:59 INFO - mozfile == 1.2 17:49:59 INFO - mozhttpd == 0.7 17:49:59 INFO - mozinfo == 0.9 17:49:59 INFO - mozleak == 0.1 17:49:59 INFO - mozlog == 3.3 17:49:59 INFO - moznetwork == 0.27 17:49:59 INFO - mozprocess == 0.23 17:49:59 INFO - mozprofile == 0.28 17:49:59 INFO - mozrunner == 6.12 17:49:59 INFO - mozscreenshot == 0.1 17:49:59 INFO - mozsystemmonitor == 0.3 17:49:59 INFO - moztest == 0.7 17:49:59 INFO - mozversion == 1.4 17:49:59 INFO - psutil == 3.1.1 17:49:59 INFO - requests == 1.2.3 17:49:59 INFO - wsgiref == 0.1.2 17:49:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:49: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')]} 17:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49: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')]} 17:49:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:59 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 0x14cd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178c3b0>, '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 0x178d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178d740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470876422.207024-630820636', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:49:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:49:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:49:59 INFO - Using env: {'DISPLAY': ':0', 17:49:59 INFO - 'HOME': '/home/cltbld', 17:49:59 INFO - 'LANG': 'en_US.UTF-8', 17:49:59 INFO - 'LANGUAGE': 'en_US:en', 17:49:59 INFO - 'LOGNAME': 'cltbld', 17:49:59 INFO - 'MAIL': '/var/mail/cltbld', 17:49:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:59 INFO - 'MOZ_NO_REMOTE': '1', 17:49:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:59 INFO - 'NO_EM_RESTART': '1', 17:49:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:59 INFO - 'PWD': '/builds/slave/test', 17:49:59 INFO - 'SHELL': '/bin/bash', 17:49:59 INFO - 'SHLVL': '1', 17:49:59 INFO - 'TERM': 'linux', 17:49:59 INFO - 'TMOUT': '86400', 17:49:59 INFO - 'USER': 'cltbld', 17:49:59 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470876422.207024-630820636', 17:49:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:59 INFO - '_': '/tools/buildbot/bin/python'} 17:50:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:50:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:50:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:50:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:50:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:50:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:50:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:50:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:50:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:50:00 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:50:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:50:00 INFO - Cleaning up... 17:50:00 INFO - Return code: 0 17:50:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:50:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:50:00 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 0x14cd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178c3b0>, '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 0x178d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178d740>, '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': '934fc3100db09dcb9af4d4b6000001ab-1470876422.207024-630820636', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:50:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:50:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:50:00 INFO - Using env: {'DISPLAY': ':0', 17:50:00 INFO - 'HOME': '/home/cltbld', 17:50:00 INFO - 'LANG': 'en_US.UTF-8', 17:50:00 INFO - 'LANGUAGE': 'en_US:en', 17:50:00 INFO - 'LOGNAME': 'cltbld', 17:50:00 INFO - 'MAIL': '/var/mail/cltbld', 17:50:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:00 INFO - 'MOZ_NO_REMOTE': '1', 17:50:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:50:00 INFO - 'NO_EM_RESTART': '1', 17:50:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:50:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:00 INFO - 'PWD': '/builds/slave/test', 17:50:00 INFO - 'SHELL': '/bin/bash', 17:50:00 INFO - 'SHLVL': '1', 17:50:00 INFO - 'TERM': 'linux', 17:50:00 INFO - 'TMOUT': '86400', 17:50:00 INFO - 'USER': 'cltbld', 17:50:00 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470876422.207024-630820636', 17:50:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:00 INFO - '_': '/tools/buildbot/bin/python'} 17:50:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:50:00 INFO - Cleaning up... 17:50:00 INFO - Return code: 0 17:50:00 INFO - Running post-action listener: _resource_record_post_action 17:50:00 INFO - Running post-action listener: _start_resource_monitoring 17:50:00 INFO - Starting resource monitoring. 17:50:00 INFO - [mozharness: 2016-08-11 00:50:00.386029Z] Finished create-virtualenv step (success) 17:50:00 INFO - [mozharness: 2016-08-11 00:50:00.386514Z] Running install step. 17:50:00 INFO - Running pre-action listener: _resource_record_pre_action 17:50:00 INFO - Running main action method: install 17:50:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:50:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:50:00 INFO - Reading from file tmpfile_stdout 17:50:00 INFO - Detecting whether we're running mozinstall >=1.0... 17:50:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:50:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:50:00 INFO - Reading from file tmpfile_stdout 17:50:00 INFO - Output received: 17:50:00 INFO - Usage: mozinstall [options] installer 17:50:00 INFO - Options: 17:50:00 INFO - -h, --help show this help message and exit 17:50:00 INFO - -d DEST, --destination=DEST 17:50:00 INFO - Directory to install application into. [default: 17:50:00 INFO - "/builds/slave/test"] 17:50:00 INFO - --app=APP Application being installed. [default: firefox] 17:50:00 INFO - mkdir: /builds/slave/test/build/application 17:50:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:50:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:50:16 INFO - Reading from file tmpfile_stdout 17:50:16 INFO - Output received: 17:50:16 INFO - /builds/slave/test/build/application/firefox/firefox 17:50:16 INFO - Running post-action listener: _resource_record_post_action 17:50:16 INFO - [mozharness: 2016-08-11 00:50:16.834886Z] Finished install step (success) 17:50:16 INFO - [mozharness: 2016-08-11 00:50:16.835134Z] Running run-tests step. 17:50:16 INFO - Running pre-action listener: _resource_record_pre_action 17:50:16 INFO - Running main action method: run_tests 17:50:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:50:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:50:16 INFO - Python 2.7.3 17:50:16 INFO - Return code: 0 17:50:16 INFO - grabbing minidump binary from tooltool 17:50: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')]} 17:50:16 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 0x178c3b0>, '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 0x178d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178d740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:50:16 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:50:16 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:50:16 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:50:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:50:16 INFO - Return code: 0 17:50:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:50:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:50:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:50:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:50:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:50:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Li5VGSHDR5GlxAyDGycIcA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 17:50:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Li5VGSHDR5GlxAyDGycIcA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 17:50:16 INFO - Using env: {'DISPLAY': ':0', 17:50:16 INFO - 'HOME': '/home/cltbld', 17:50:16 INFO - 'LANG': 'en_US.UTF-8', 17:50:16 INFO - 'LANGUAGE': 'en_US:en', 17:50:16 INFO - 'LOGNAME': 'cltbld', 17:50:16 INFO - 'MAIL': '/var/mail/cltbld', 17:50:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:50:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:50:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:16 INFO - 'MOZ_NO_REMOTE': '1', 17:50:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:50:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:50:16 INFO - 'NO_EM_RESTART': '1', 17:50:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:50:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:16 INFO - 'PWD': '/builds/slave/test', 17:50:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:50:16 INFO - 'SHELL': '/bin/bash', 17:50:16 INFO - 'SHLVL': '1', 17:50:16 INFO - 'TERM': 'linux', 17:50:16 INFO - 'TMOUT': '86400', 17:50:16 INFO - 'USER': 'cltbld', 17:50:16 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1470876422.207024-630820636', 17:50:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:16 INFO - '_': '/tools/buildbot/bin/python'} 17:50:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Li5VGSHDR5GlxAyDGycIcA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:50:17 INFO - mozversion application_buildid: 20160810163021 17:50:17 INFO - mozversion application_changeset: dc8f8117d67b5ae9c7b42b72e3567ef5e754b1fa 17:50:17 INFO - mozversion application_display_name: Nightly 17:50:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:50:17 INFO - mozversion application_name: Firefox 17:50:17 INFO - mozversion application_remotingname: firefox 17:50:17 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:50:17 INFO - mozversion application_vendor: Mozilla 17:50:17 INFO - mozversion application_version: 51.0a1 17:50:17 INFO - mozversion platform_buildid: 20160810163021 17:50:17 INFO - mozversion platform_changeset: dc8f8117d67b5ae9c7b42b72e3567ef5e754b1fa 17:50:17 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:50:17 INFO - mozversion platform_version: 51.0a1 17:50:17 INFO - using testdate: 1470876617 17:50:17 INFO - actual date: 1470876617 17:50:17 INFO - starting webserver on 'localhost:36434' 17:50:17 INFO - SUITE-START | Running 2 tests 17:50:17 INFO - TEST-START | dromaeo_css 17:50:17 INFO - operating with platform_type : linux_ 17:50:17 INFO - Initialising browser for dromaeo_css test... 17:50:17 INFO - TEST-INFO | started process 2563 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXrbjQR/profile http://localhost:36434/getInfo.html) 17:50:21 INFO - PROCESS | 2563 | __metrics Screen width/height:1600/1200 17:50:21 INFO - PROCESS | 2563 | colorDepth:24 17:50:21 INFO - PROCESS | 2563 | Browser inner width/height: 1024/697 17:50:21 INFO - PROCESS | 2563 | __metrics 17:50:22 INFO - PROCESS | 2563 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:50:22 INFO - PROCESS | 2563 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:50:22 INFO - PROCESS | 2563 | console.error: PushService: 17:50:22 INFO - PROCESS | 2563 | stateChangeProcessEnqueue: Error transitioning state 17:50:22 INFO - PROCESS | 2563 | UnknownError 17:50:23 INFO - TEST-INFO | 2563: exit 0 17:50:23 INFO - Browser initialized. 17:50:23 INFO - Running cycle 1/1 for dromaeo_css test... 17:50:23 INFO - TEST-INFO | started process 2643 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXrbjQR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:50:35 INFO - PROCESS | 2643 | RSS: Main: 157319168 17:50:35 INFO - PROCESS | 2643 | 17:51:26 INFO - PROCESS | 2643 | 1470876686234 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:53:39 INFO - PROCESS | 2643 | Cycle 1(1): loaded http://localhost:36434/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36434/tests/dromaeo/cssquery-ext.html) 17:53:40 INFO - PROCESS | 2643 | RSS: Main: 235376640 17:53:40 INFO - PROCESS | 2643 | 17:56:43 INFO - PROCESS | 2643 | Cycle 1(1): loaded http://localhost:36434/tests/dromaeo/cssquery-ext.html (next: http://localhost:36434/tests/dromaeo/cssquery-jquery.html) 17:56:43 INFO - PROCESS | 2643 | RSS: Main: 247664640 17:56:43 INFO - PROCESS | 2643 | 17:59:46 INFO - PROCESS | 2643 | Cycle 1(1): loaded http://localhost:36434/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36434/tests/dromaeo/cssquery-mootools.html) 17:59:46 INFO - PROCESS | 2643 | RSS: Main: 189321216 17:59:46 INFO - PROCESS | 2643 | 18:02:48 INFO - PROCESS | 2643 | Cycle 1(1): loaded http://localhost:36434/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36434/tests/dromaeo/cssquery-prototype.html) 18:02:49 INFO - PROCESS | 2643 | RSS: Main: 190459904 18:02:49 INFO - PROCESS | 2643 | 18:05:52 INFO - PROCESS | 2643 | Cycle 1(1): loaded http://localhost:36434/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36434/tests/dromaeo/cssquery-yui.html) 18:05:53 INFO - PROCESS | 2643 | RSS: Main: 188932096 18:05:53 INFO - PROCESS | 2643 | 18:08:56 INFO - PROCESS | 2643 | Cycle 1(1): loaded http://localhost:36434/tests/dromaeo/cssquery-yui.html (next: http://localhost:36434/tests/dromaeo/cssquery-dojo.html) 18:08:56 INFO - PROCESS | 2643 | RSS: Main: 280621056 18:08:56 INFO - PROCESS | 2643 | 18:08:56 INFO - PROCESS | 2643 | __start_tp_report 18:08:56 INFO - PROCESS | 2643 | _x_x_mozilla_page_load 18:08:56 INFO - PROCESS | 2643 | _x_x_mozilla_page_load_details 18:08:56 INFO - PROCESS | 2643 | |i|pagename|runs| 18:08:56 INFO - PROCESS | 2643 | |0;dojo.html;2642.2469596165092;2648.523265812153;2680.892764289429;2695.7304269573033;2701.5677491601346;4575.565321294472;4673.976630116853;4762.571368576828;4873.5613794758465;4891.584215341701;4712.505186955372;4732.692374995623;4749.8812529686775;4777.593904518111;4807.062622788558;4375.453068366454;4411.338299255105;4428.424304840366;4441.911161776762;4518.638508919278;4354.629856462205;4474.440694913136;4509;4514.0746147039945;4555.612772914306;4239.0674051708575;4307.224699554079;4444.73331600105;4445.73325600465;4502.369668246448;4319.308910574293;4374.934375984363;4391.363252328394;4421.801018954155;4459.2865141577195;4372.060007098457;4398.450193725785;4400.801963911632;4436.955630443719;4441;4606.884827879297;4787.904241915177;4832.1543729847135;4834.468208497063;4848.46666866648;5060.721660308682;5151.66514176581;5153.665011774223;5243.318368612094;5245;5258.92111618326;5264.052470555299;5265.21021846726;5273.050850846846;5274.05067087924;4625.953740462553;4904.975475122602;4914.508549145057;4921.876953076202;4922.089413458521;5226.947730522646;5249.527542521191;5270.525652691276;5336.386315573681;5369.946300537023;5059.645824792303;5108.106081435734;5117.104506711311;5135.460776618476;5136.897262054813;5154.329937108152;5171.431142574389;5175.275461435402;5211.114110601131;5221.660592061504;4796.760161991956;5017.1721665924715;5061.089003979246;5094;5105.795768169231;5158.303629010111;5162.251473536391;5163.251328557338;5174.534291913746;5214.97392513035;4394.231009573312;4442.222611043055;4448.5551444855255;4484.327350897326;4492.460904691458;3724.2179142380405;3728.9440658390145;3811.294910441577;3812.5996770338716;3873.845046198177;4418.8453404130705;4447.688661793643;4453.1761624099645;4491.393661855673;4491.618212451978;5225.399079105951;5232.189010703347;5232.39827419844;5233.659812112277;5283.260343551906;4167.354060120626;4368.235558777201;4442.622377097919;4450.06548624786;4498.190325741332;4570.085982803453;4611.538846115429;4630.282306242538;4643.883902902455;4646.372739680168;4736.052789442194;4786.8085276589245;4789.808407663654;4793.113274044313;4828.613710903049;4920.434150072788;5095.210242412432;5109.565686916654;5112.590992720648;5158.613104017289;4735.857924262277;4738.407699037621;4739.360186374795;4755;4813.229883218668;5028.094942910311;5047.949520504748;5049.84850454487;5053.469385714594;5109.565686916654;4874.171390863491;5058.64589478733;5068.873278168076;5072.340595722532;5121.564667003197;4890.413150421972;4943.703377797344;5009.0482808266315;5039.067772462106;5063.645544811975;5015.5987520997505;5027.673201241908;5028.472010438997;5036.143855544493;5075.822346218012;4640.651951103749;4938.259261110718;4954.653174277766;4987.850364489072;4999.125153098266;4972.254161875748;5020.3724534433195;5035.949640503548;5078.9238161426865;5103.8468845934685;4950.628702847373;4959.330490383752;4959.504049595012;4961.404631444249;5010.248462730474 18:08:56 INFO - PROCESS | 2643 | |1;ext.html;560.2576586023519;567.1606023085833;570.9800156994503;573.9167820666004;587.8677297608042;28469.57295640567;41830.79084604576;42830.35754463682;42875.78562107185;42981.57018429815;40105.7994710026;40298.59701402985;40506.18987620246;40528.39207411884;40533;7697.499662521946;7869.449138560274;7870.409719271078;7873.330766884822;7882.921170788276;7699.34555562775;7805.843883122334;7806;7810.80472988177;7815;7813.257740514642;7834.0990786059765;7840.607969601526;7862;7862.331701805353;7770.689172433096;7814.804629884242;7830.2169783021245;7839.804004899866;7841.686332546691;7568.5458872467825;7619.885701714424;7624.809379765495;7633.313001829806;7649.196834332426;37481.43777843335;37788.62211377879;37824.62175378238;37831;37901;3244.4646633305474;3326.9334613307597;3440.346334196495;3579.7673151245085;3786.488824008751;28626.284342891387;29271.121866344045;29278.707212928024;29288.853555732298;29296.56055159174;3332.4001679697644;3379.6958273755235;3394.8811791587423;3532.2229109595846;3533.1873669056004;263085;263561;263631;264379.9999999981;265689;31437.842810786256;32291.35417291688;52662.473375265756;53100.46899531032;53211;33400.33199336;33608.83195584006;33632.663673363444;33642.49536256958;33671.15822104418;12986.220826750236;12996.675083122998;13011.154274972096;13022.088453808332;13103.541376051793;11018.228723989243;11144.777104458028;11157.609483668195;11160.776784464266;11167.609133680282;7756.728514501965;7872.842543149105;7879.803004924923;7942.166072562413;7961.363090952826;3083.2137804859617;3086.0777060588325;3104.7360974317435;3109.4247564200696;3186.426443240239;833.2833762963846;854.7307598106577;870.8345414371249;919.6689191890914;955.7515046087929;26722.19833405001;27960.462174580593;28393.716062839107;28778.71221287802;28977.85511072431;814.7840822182127;921.9354645174774;957.6648173139484;958.6213445688913;1089.84742136101;13952.86047139536;14733.778993315109;14863;14996.625084372978;15110.773338399933;375255;379657;379996;380711;381746.91265436617;47132.764336178785;47559.762201189464;47627.76186119047;47659;47737.522624774;1072.9034386905216;1158.7914175448332;1164.976700465986;1187.4715751490676;1188.1920294200027;27766.305842354104;29036.419271614872;29106.479931647715;29346.55980160342;29717.85141074281;40883;40918;41225.79387103045;41389.1722165549;41417.37873931954;300370;302556;302962;303173;581470;35519;36278.637213627524;36298.27403451969;36518.8174059128;36903.26193476169;39418.605813941496;39603.80198098991;39936.80031599823;40108;40362;34021.149471263416;34170.82914585411;34560.65439345675;34667;34894.476582851785;33762.831185844894;34119.48820767641;34435.65564344324;34607.480887787206;35460.46809297811;34043.14892127617;34282.14294642654;34361.82819085888;34670.65329346674;41180.16008920384;35051.649483504836;35171;37255.8137209323;37452.43821342628;39307.2138557233;30780.99159101164;30808.691913080584;30821.22946926345;30854.228644284074;31011.224719382197 18:08:56 INFO - PROCESS | 2643 | |2;jquery.html;333.1787144688343;336.46334097115107;355.81141994742785;360.5205077247262;378.70082634718574;12651.240925544462;16046.117463539515;16736.079515626636;17127.57181070474;18241.726374104364;15744.606384840356;16160.515184544452;16625.168741562935;16767.580810479743;16805.663886722257;4886.462489126193;5063.670861394016;5095.3885533736;5286.682799032051;5345;3471.5313432686644;5025.7235852028125;5257.8948421031555;5285.2600635911;5294.947050529484;5309.858380448203;5353.705546194958;5365.302510673607;5379.193121031837;5381.623286369956;5173.094708426011;5281.894362112736;5315.574754019669;5369;5373.7581808818695;5169.431362550116;5172.61205409592;5176.378834539879;5183.429822719498;5194;11899;16487.587810304718;20612.58774824495;20648.896755516278;20839.8958005209;1820.4902627264387;1838.7517685112473;1852.6850435425874;1919.5009297582728;1958.921643134273;12758.36208189596;13044.673883152902;13052.477900883954;13175.407106680223;13841.30793460323;1696.9406070787586;1821.0985562146689;1834.4496651004645;1877.1271358818078;1878.5209771508178;71909;72681;72695.63652181758;73125.63437182833;73355.63322183354;10030.548625311732;10199.7450063749;10322.896771032194;10393.792124157626;10593.947030264953;13892.374843131882;13898.652533686536;13912.234827084607;13936.233507157203;13940.163590184622;6967.686454109577;7271.309225623558;7312.524685895506;7393.926060739432;7447.702091916371;6904.240533541307;6928.44572434204;7132.358087772125;7163.283671632795;7180.712771489187;4254.595813397722;4344.717593356485;4356.499002614676;4453.933191002137;4472.396226509444;1739.5216315513082;1770.97343539847;1771.5659663382553;1813.8820976636475;1828.6616975859508;800.9038915330198;821.9876701849477;886.2156991062827;889.6263569300779;898.2409863665192;16928.661426771396;17756.20097095608;17985;18120.456386308433;18152.27390904349;832.7252006837729;839.9244068033906;849.668629234599;889.1286539191499;890.0609856601347;9377.484238366955;10046.19630429564;10079.193664506822;10082.49587520621;10172.643957461454;377237;380318;385897;386043;387180;49730;75592.62203688946;75720;76872.61563692258;78639.99999999885;887.1793590928365;902.8916530016309;916.7937214126769;917.9219766319937;924.3714274293545;15208.771868422204;15725.921370393533;16119.838801612303;16344.509664710078;16440.095794731405;37149;37282;38146.618533814304;42229.78885105555;43159.78420108005;54660.72669636626;56515.434845652664;56544.15183772164;56654;58384;7390.667419966222;7586.24137586237;7685.193054729173;7858.764237072897;7995.200479951958;9601.423914565148;12166.087543434454;12179.512819487476;12783.872161278268;12868.742625147257;10247.846282305622;10481.947590262;10519.842202366817;10640.627578034731;10774.299670521392;10626.25616206889;10660.360378377321;10697.090747286256;10793.514291857042;10802.351858888493;10231.590736370461;10244.692659220234;10365.481725913825;10371.325863818827;11504.884951150716;7549.2073332299315;7632;7688.807779805549;7983.520988740462;8048.114707382067;9241.353105282566;9961.302708810314;10068.295219334575;10134.442605656759;10407.115395191493 18:08:56 INFO - PROCESS | 2643 | |3;mootools.html;1246.7755803955297;1357.8574249703781;1395.9302034898255;1452.7021960498098;1680.6218600814818;6554.082428460013;7504.66229019694;7739.806504837382;7742.767716968493;8084;7868.449208555404;7941.12647608764;7944.563049032301;7945.483543569664;7954.045514538264;2146;2180.90185941633;2181.2365672014826;2181.7818218178136;2181.9781802182015;2119.5231073008604;2169.229923377202;2194;2200.8679479231296;2201.0975500044983;2136.380449669594;2143.153454385517;2150.2689085710854;2151.580441813847;2199.5820794049077;2103.852730308879;2105.6736205888037;2111.1660893946882;2111.5565731196466;2112.049577690038;2059.7322348094804;2103.9474013149793;2104.379208133604;2106.73665791776;2108.5782843431375;7281.490295679305;7764.961175194087;7837.921620783776;7845.725399610987;7913.9604301978125;4311.568843115663;4506.842260520899;4512.435945506812;4517.435320584927;4519.864404067883;2853.9001134960176;2950.4541659792794;3007.7593792496546;3016.9547456788164;3024.6219222597174;947.3747326764371;952.4095061062186;965.097633712474;984.3208186351395;993.8707967964191;10586.41774702391;10588.788224235472;10675.626353077605;10695.679129626124;10695.732606684895;3803.3534299168655;3914.197589494147;3954.8022598869943;4033.092554175346;4044.3326851069833;8363.832723345498;8485.490870547786;8489.4481858679;8506.702265420681;8518.403711740242;4420.447444069491;4427.026054268056;4428;4429.313456414261;4435.2016637005;3334.333133373335;3583.480395342661;3718.761911277467;4126.360414135814;4130.380442933524;3189.5694081299193;3286.2277364819247;3363.3273345330545;3367.7642565020215;3435.5362026126654;961.697065424389;968.7529679931572;969.5976169889417;970.7912798748303;977.7946631207384;796.4783067091065;797.1709422200962;804.2359758229705;817.7710241132493;820.2535692519779;4932.802687892444;5124.5131712487255;5140.56305214061;5146.948530514722;5194.337991715831;353.41333386578157;355.0661759572308;356.939320315547;361.5011284427526;366.4137380191725;3567.108222944264;3649.5802982656805;3680.0799800049986;3695.2240029594086;3746.6066063062985;9430.905690943002;9861.901380986243;9897;9915;9915.702528924145;8843.955780221058;9731.805363892683;9757.609695612096;9770.462624555576;9785.315027948118;7050.506464547432;7348.77953661391;7357.742479013209;7371.6682749276415;7391.260873912565;5320.5477534408465;5530.419305972815;5550;5604.103343465026;5662.499437649109;8581.742547723577;8688.30493560501;8826.161514656098;8956.955215224143;8958.10418958099;8937.195652391316;9042.593083311136;9133.634654614007;9188.678396256098;9217.723468295962;6865.622390768555;7023.613701246276;7034.824129396806;7039.54242974205;7045.436365090883;7259.818504537428;7323.7436689715605;7329.706811727471;7450.776476705708;7538.811529711801;6814.522983391115;6852.8286792828585;6901.723931042702;6911.827204319731;6944.340287672663;6554.8361290966195;6639.236487803964;6688.130543029375;6812.489063320171;6832.180138383425;6381.3937675920715;6483.448906842783;6485;6485.221773387224;6488.026795980451;4567.086582683411;4634.32802243666;4669.252919532859;4719.244920812654;4751.904961900674;4647.721136731807;4658.20810462229;4703.365045718784;4746.406699162605;4951.455339912534 18:08:56 INFO - PROCESS | 2643 | |4;prototype.html;280.3975281267557;287.7582830422445;297.89126968656444;298.5640964192279;299.6060180862167;4864.927026094607;4895.192293271611;4907.497176440014;4912.7297998610065;4975.776090075946;4629.421322334708;4686.718796872182;4738.6446016548725;4805.399325084364;4872.415310162785;3805.809709514513;3818.885433437001;3821.8853434396874;3826.215625796719;3842.8270727817317;3811.8856434306877;3822.7706337619693;3842.769433833979;3855.3350445960423;3864.3237433449176;3608.6932610728118;3672.797996110213;3782.9621703783023;3796.335641262782;3796.7721936683747;3786.6213378662187;3804.733668643196;3821.48409964654;3822.6559609635265;3832.7891965941863;3365.4278772608473;3367.2760356523463;3367.7810942288675;3370.7640465167447;3379.2227787608986;4475.597196252353;4729.888476208088;4760;4797.40032495938;4803.855884323476;4174.519930208005;4202.781193453895;4203.372891942536;4207.431996680471;4231.513375961773;5015.498450154992;5016.77424515894;5028.472010438888;5063.215201643714;5071.898562028776;3539.752217344787;3561.1631266652316;3567.1973805893726;3572.3034008368377;3575.3564358415474;5059.999999999964;5268.49847793377;5278.340207474066;5303.761330740087;5316.282301889234;3585.4980302757635;3615.9096022599647;3622.2574372253625;3627.3289441453417;3630.981845090758;3699.2601479704167;3699.3537875645616;3710.981445092811;3715.2198038412234;3717.9070523237137;4194.370844373308;4285.821399115268;4285.892852678708;4293.184294983943;4333;4965.577925876269;4976.651634385631;5021.799128034911;5033.597312215014;5036.194208926628;1271.7536813922409;1311.141202512356;1311.3639884655934;1327.1373607155233;1327.6614463311794;841.4908980067094;852.9275011624081;874.7987962768599;881.7090360181124;883.3992884838372;4341.544137865541;4341.891452713708;4483.94627262593;4486.842960496367;4487.528809475023;5216.321878155892;5218.191180366974;5222.764975576109;5251.2123181523075;5254.448282930313;4269.380939763717;4478.731276123443;4482.28283474649;4513.796879140446;4520.118576877478;2757.6828664703417;2799.768102035098;2801.817881837674;2802.215379693689;2803.2431243564124;4969.3291405659775;4970.527799859007;4978;4996.300517927493;5000.599952003831;5086.516780905808;5346.679199247979;5380.542653874386;5415.702136382458;5424.349078110652;4930.334404855299;4934.458753741826;4942.75286235694;4951.925721114186;4955.40535135786;5237.554807841376;5243.318368612056;5253.947460525499;5255.264263003259;5268.1834315681135;4912.508749125059;5142.6914385137015;5158.045761534128;5159.716215608178;5210.645232239721;4923.852284431473;4926.975365123151;4928.29973659087;4934.136526107988;4941.33292005589;3651.141981634261;3686.170611612473;3744.8876533704033;3746.981265093657;3747.812609369466;5194.96100779838;5254.605904557097;5267.7366131694025;5291.8677033072945;5351.224072509543;5066.138756411346;5074.695518268915;5089;5093.638198788782;5103.260027296095;5030.874228144326;5106.693598384109;5106.923396148986;5122.359705036871;5138.203578445347;4844.685095468783;4955.479674634112;4974.7512624369365;4982.252662100714;5001.599872010303;4867.805287788448;4917.852464426073;5101.897962040813;5106.8509585343;5114.3862736471865;5016.598672106295;5018.397792264952;5076.11168045598;5080.872978175576;5089.567386772166 18:08:56 INFO - PROCESS | 2643 | |5;yui.html;639.335091504835;651.4365074210809;662.7647185249233;680.244928129776;699.3076853914625;13234.338283085843;13778.379972901219;14410;14437.855621443783;14442.638934026654;14655.120692758443;15368;15422.460213892487;15427.69144617107;15430.305636246369;623.9188905442286;756.6859753202428;781.2304879693497;784.4900814470583;785.0148064179475;640.5068097564872;648.6659370424235;649.3701109923367;649.5680372552247;742.4320394897908;804.7545498622918;805.5609692717483;813.7762115418249;814.7596459044566;815.2621877201112;803.4817542684993;806.6249194124731;806.8305655812286;807.0114110214998;807.2532907060945;478.15128147538053;575.2320651929679;592.0793166625895;592.0822724776579;592.943670351316;13599.388027538784;13627.114237574526;13639.386227619781;13661.385237664328;13672.863271367258;12354.75290494185;12436.937815310956;12489.188202766882;12655.367231638473;13283.601491955256;11510.194286399956;11579.826302605383;11641.41792910351;11788.587399441065;12023.759524809542;3955.268275369066;4048.210598933209;4056.553779084298;4105.035316700573;4133.46264985553;64953.675231623536;66454.66772666202;67864.3213567868;67983.32016679869;68267.65866170687;9864.358816676893;10316.845247321296;10382.948085259526;10394.48027598617;10695.144388448905;18744.718829217574;18957.24171033171;19085.332013379466;19086.52283692891;19094;6765;7190.604516751629;7304.306090921354;7328.413726901835;7352.5220860643885;3770.7171962102952;3801.790901500389;3853.325668008087;3947.4868267125667;3948.506436695413;2717.0761940940174;2839.7444230019396;2850.372917958046;2850.7719382449354;2852.5150724376904;486.7055431463984;487.9634027447956;489.4053724724477;497.07295893159;511.43486447475004;571.2602180176681;607.781198768443;623.8066199478086;626.2985456288985;630.0989584893646;7922.683092676343;8207.220314070273;8436.704715335056;8867.91132088671;8917.464952102764;580.7415700013538;583.174807647183;587.6767777722235;594.4441946779775;610.7709608896664;4092.8567500137947;4109.3425051991535;4150.398192262105;4218.7468751874985;4345.3699213613845;107052.5221681252;107726;108893;110300;112380.43809780899;90097;93216.53391732997;93743.53128234314;94065.52967235257;94546;76452;78768.60615696885;78950.21049789543;80858.59570702109;83498.58250708708;7911.525308481279;8205.753827385188;8352.58237088131;8462.280706140047;8482.703105391281;47986.52013479821;48779.512204877494;49582.50417495779;49885.25172122494;50847.74576127244;66306;66720;73258.63370683113;73509.26490735238;73861.63069184619;9783.804323913624;10185.49072546355;10244.692659220234;10315.226358023028;10384.74038149022;10761.515731792244;10818;10855.67432977012;11160.10719142483;11524.481398336928;10688.73278168021;10753.193510486588;10984.231103822656;11412.48643811047;11520.711982200512;10119.139873110867;10125.848112278174;10305.381677099398;10560.155187584822;10621.15030797519;10986.780264394507;11913.463894124958;12149.149559530748;12184.086193535697;12367.396133196624;10165.390076595428;10246.957981178635;10368.792624147625;10382.90320490137;10667.51996160159;10184;10355.361163180605;10568;10586.947065264625;10596.47017649099 18:08:56 INFO - PROCESS | 2643 | __end_tp_report 18:08:56 INFO - PROCESS | 2643 | __start_cc_report 18:08:56 INFO - PROCESS | 2643 | _x_x_mozilla_cycle_collect,1150 18:08:56 INFO - PROCESS | 2643 | __end_cc_report 18:08:56 INFO - PROCESS | 2643 | __startTimestamp1470877736575__endTimestamp 18:08:56 INFO - PROCESS | 2643 | 18:08:56 INFO - PROCESS | 2643 | ------- Summary: start ------- 18:08:56 INFO - PROCESS | 2643 | Number of tests: 6 18:08:56 INFO - PROCESS | 2643 | 18:08:56 INFO - PROCESS | 2643 | [#0] dojo.html Cycles:165 Average:4750.28 Median:4874.17 stddev:505.68 (10.4%) stddev-sans-first:479.43 18:08:56 INFO - PROCESS | 2643 | Values: 2642.2 2648.5 2680.9 2695.7 2701.6 4575.6 4674.0 4762.6 4873.6 4891.6 4712.5 4732.7 4749.9 4777.6 4807.1 4375.5 4411.3 4428.4 4441.9 4518.6 4354.6 4474.4 4509.0 4514.1 4555.6 4239.1 4307.2 4444.7 4445.7 4502.4 4319.3 4374.9 4391.4 4421.8 4459.3 4372.1 4398.5 4400.8 4437.0 4441.0 4606.9 4787.9 4832.2 4834.5 4848.5 5060.7 5151.7 5153.7 5243.3 5245.0 5258.9 5264.1 5265.2 5273.1 5274.1 4626.0 4905.0 4914.5 4921.9 4922.1 5226.9 5249.5 5270.5 5336.4 5369.9 5059.6 5108.1 5117.1 5135.5 5136.9 5154.3 5171.4 5175.3 5211.1 5221.7 4796.8 5017.2 5061.1 5094.0 5105.8 5158.3 5162.3 5163.3 5174.5 5215.0 4394.2 4442.2 4448.6 4484.3 4492.5 3724.2 3728.9 3811.3 3812.6 3873.8 4418.8 4447.7 4453.2 4491.4 4491.6 5225.4 5232.2 5232.4 5233.7 5283.3 4167.4 4368.2 4442.6 4450.1 4498.2 4570.1 4611.5 4630.3 4643.9 4646.4 4736.1 4786.8 4789.8 4793.1 4828.6 4920.4 5095.2 5109.6 5112.6 5158.6 4735.9 4738.4 4739.4 4755.0 4813.2 5028.1 5047.9 5049.8 5053.5 5109.6 4874.2 5058.6 5068.9 5072.3 5121.6 4890.4 4943.7 5009.0 5039.1 5063.6 5015.6 5027.7 5028.5 5036.1 5075.8 4640.7 4938.3 4954.7 4987.9 4999.1 4972.3 5020.4 5035.9 5078.9 5103.8 4950.6 4959.3 4959.5 4961.4 5010.2 18:08:56 INFO - PROCESS | 2643 | 18:08:56 INFO - PROCESS | 2643 | [#1] ext.html Cycles:180 Average:47793.39 Median:36408.55 stddev:90982.81 (249.9%) stddev-sans-first:91168.93 18:08:56 INFO - PROCESS | 2643 | Values: 560.3 567.2 571.0 573.9 587.9 28469.6 41830.8 42830.4 42875.8 42981.6 40105.8 40298.6 40506.2 40528.4 40533.0 7697.5 7869.4 7870.4 7873.3 7882.9 7699.3 7805.8 7806.0 7810.8 7815.0 7813.3 7834.1 7840.6 7862.0 7862.3 7770.7 7814.8 7830.2 7839.8 7841.7 7568.5 7619.9 7624.8 7633.3 7649.2 37481.4 37788.6 37824.6 37831.0 37901.0 3244.5 3326.9 3440.3 3579.8 3786.5 28626.3 29271.1 29278.7 29288.9 29296.6 3332.4 3379.7 3394.9 3532.2 3533.2 263085.0 263561.0 263631.0 264380.0 265689.0 31437.8 32291.4 52662.5 53100.5 53211.0 33400.3 33608.8 33632.7 33642.5 33671.2 12986.2 12996.7 13011.2 13022.1 13103.5 11018.2 11144.8 11157.6 11160.8 11167.6 7756.7 7872.8 7879.8 7942.2 7961.4 3083.2 3086.1 3104.7 3109.4 3186.4 833.3 854.7 870.8 919.7 955.8 26722.2 27960.5 28393.7 28778.7 28977.9 814.8 921.9 957.7 958.6 1089.8 13952.9 14733.8 14863.0 14996.6 15110.8 375255.0 379657.0 379996.0 380711.0 381746.9 47132.8 47559.8 47627.8 47659.0 47737.5 1072.9 1158.8 1165.0 1187.5 1188.2 27766.3 29036.4 29106.5 29346.6 29717.9 40883.0 40918.0 41225.8 41389.2 41417.4 300370.0 302556.0 302962.0 303173.0 581470.0 35519.0 36278.6 36298.3 36518.8 36903.3 39418.6 39603.8 39936.8 40108.0 40362.0 34021.1 34170.8 34560.7 34667.0 34894.5 33762.8 34119.5 34435.7 34607.5 35460.5 34043.1 34282.1 34361.8 34670.7 41180.2 35051.6 35171.0 37255.8 37452.4 39307.2 30781.0 30808.7 30821.2 30854.2 31011.2 18:08:56 INFO - PROCESS | 2643 | 18:08:56 INFO - PROCESS | 2643 | [#2] jquery.html Cycles:180 Average:24375.40 Median:209232.31 stddev:63384.23 (30.3%) stddev-sans-first:63536.33 18:08:56 INFO - PROCESS | 2643 | Values: 333.2 336.5 355.8 360.5 378.7 12651.2 16046.1 16736.1 17127.6 18241.7 15744.6 16160.5 16625.2 16767.6 16805.7 4886.5 5063.7 5095.4 5286.7 5345.0 3471.5 5025.7 5257.9 5285.3 5294.9 5309.9 5353.7 5365.3 5379.2 5381.6 5173.1 5281.9 5315.6 5369.0 5373.8 5169.4 5172.6 5176.4 5183.4 5194.0 11899.0 16487.6 20612.6 20648.9 20839.9 1820.5 1838.8 1852.7 1919.5 1958.9 12758.4 13044.7 13052.5 13175.4 13841.3 1696.9 1821.1 1834.4 1877.1 1878.5 71909.0 72681.0 72695.6 73125.6 73355.6 10030.5 10199.7 10322.9 10393.8 10593.9 13892.4 13898.7 13912.2 13936.2 13940.2 6967.7 7271.3 7312.5 7393.9 7447.7 6904.2 6928.4 7132.4 7163.3 7180.7 4254.6 4344.7 4356.5 4453.9 4472.4 1739.5 1771.0 1771.6 1813.9 1828.7 800.9 822.0 886.2 889.6 898.2 16928.7 17756.2 17985.0 18120.5 18152.3 832.7 839.9 849.7 889.1 890.1 9377.5 10046.2 10079.2 10082.5 10172.6 377237.0 380318.0 385897.0 386043.0 387180.0 49730.0 75592.6 75720.0 76872.6 78640.0 887.2 902.9 916.8 917.9 924.4 15208.8 15725.9 16119.8 16344.5 16440.1 37149.0 37282.0 38146.6 42229.8 43159.8 54660.7 56515.4 56544.2 56654.0 58384.0 7390.7 7586.2 7685.2 7858.8 7995.2 9601.4 12166.1 12179.5 12783.9 12868.7 10247.8 10481.9 10519.8 10640.6 10774.3 10626.3 10660.4 10697.1 10793.5 10802.4 10231.6 10244.7 10365.5 10371.3 11504.9 7549.2 7632.0 7688.8 7983.5 8048.1 9241.4 9961.3 10068.3 10134.4 10407.1 18:08:56 INFO - PROCESS | 2643 | 18:08:56 INFO - PROCESS | 2643 | [#3] mootools.html Cycles:180 Average:5089.66 Median:5425.48 stddev:2910.92 (53.7%) stddev-sans-first:2904.76 18:08:56 INFO - PROCESS | 2643 | Values: 1246.8 1357.9 1395.9 1452.7 1680.6 6554.1 7504.7 7739.8 7742.8 8084.0 7868.4 7941.1 7944.6 7945.5 7954.0 2146.0 2180.9 2181.2 2181.8 2182.0 2119.5 2169.2 2194.0 2200.9 2201.1 2136.4 2143.2 2150.3 2151.6 2199.6 2103.9 2105.7 2111.2 2111.6 2112.0 2059.7 2103.9 2104.4 2106.7 2108.6 7281.5 7765.0 7837.9 7845.7 7914.0 4311.6 4506.8 4512.4 4517.4 4519.9 2853.9 2950.5 3007.8 3017.0 3024.6 947.4 952.4 965.1 984.3 993.9 10586.4 10588.8 10675.6 10695.7 10695.7 3803.4 3914.2 3954.8 4033.1 4044.3 8363.8 8485.5 8489.4 8506.7 8518.4 4420.4 4427.0 4428.0 4429.3 4435.2 3334.3 3583.5 3718.8 4126.4 4130.4 3189.6 3286.2 3363.3 3367.8 3435.5 961.7 968.8 969.6 970.8 977.8 796.5 797.2 804.2 817.8 820.3 4932.8 5124.5 5140.6 5146.9 5194.3 353.4 355.1 356.9 361.5 366.4 3567.1 3649.6 3680.1 3695.2 3746.6 9430.9 9861.9 9897.0 9915.0 9915.7 8844.0 9731.8 9757.6 9770.5 9785.3 7050.5 7348.8 7357.7 7371.7 7391.3 5320.5 5530.4 5550.0 5604.1 5662.5 8581.7 8688.3 8826.2 8957.0 8958.1 8937.2 9042.6 9133.6 9188.7 9217.7 6865.6 7023.6 7034.8 7039.5 7045.4 7259.8 7323.7 7329.7 7450.8 7538.8 6814.5 6852.8 6901.7 6911.8 6944.3 6554.8 6639.2 6688.1 6812.5 6832.2 6381.4 6483.4 6485.0 6485.2 6488.0 4567.1 4634.3 4669.3 4719.2 4751.9 4647.7 4658.2 4703.4 4746.4 4951.5 18:08:56 INFO - PROCESS | 2643 | 18:08:56 INFO - PROCESS | 2643 | [#4] prototype.html Cycles:180 Average:4215.18 Median:4866.37 stddev:1224.82 (25.2%) stddev-sans-first:1192.12 18:08:56 INFO - PROCESS | 2643 | Values: 280.4 287.8 297.9 298.6 299.6 4864.9 4895.2 4907.5 4912.7 4975.8 4629.4 4686.7 4738.6 4805.4 4872.4 3805.8 3818.9 3821.9 3826.2 3842.8 3811.9 3822.8 3842.8 3855.3 3864.3 3608.7 3672.8 3783.0 3796.3 3796.8 3786.6 3804.7 3821.5 3822.7 3832.8 3365.4 3367.3 3367.8 3370.8 3379.2 4475.6 4729.9 4760.0 4797.4 4803.9 4174.5 4202.8 4203.4 4207.4 4231.5 5015.5 5016.8 5028.5 5063.2 5071.9 3539.8 3561.2 3567.2 3572.3 3575.4 5060.0 5268.5 5278.3 5303.8 5316.3 3585.5 3615.9 3622.3 3627.3 3631.0 3699.3 3699.4 3711.0 3715.2 3717.9 4194.4 4285.8 4285.9 4293.2 4333.0 4965.6 4976.7 5021.8 5033.6 5036.2 1271.8 1311.1 1311.4 1327.1 1327.7 841.5 852.9 874.8 881.7 883.4 4341.5 4341.9 4483.9 4486.8 4487.5 5216.3 5218.2 5222.8 5251.2 5254.4 4269.4 4478.7 4482.3 4513.8 4520.1 2757.7 2799.8 2801.8 2802.2 2803.2 4969.3 4970.5 4978.0 4996.3 5000.6 5086.5 5346.7 5380.5 5415.7 5424.3 4930.3 4934.5 4942.8 4951.9 4955.4 5237.6 5243.3 5253.9 5255.3 5268.2 4912.5 5142.7 5158.0 5159.7 5210.6 4923.9 4927.0 4928.3 4934.1 4941.3 3651.1 3686.2 3744.9 3747.0 3747.8 5195.0 5254.6 5267.7 5291.9 5351.2 5066.1 5074.7 5089.0 5093.6 5103.3 5030.9 5106.7 5106.9 5122.4 5138.2 4844.7 4955.5 4974.8 4982.3 5001.6 4867.8 4917.9 5101.9 5106.9 5114.4 5016.6 5018.4 5076.1 5080.9 5089.6 18:08:56 INFO - PROCESS | 2643 | 18:08:56 INFO - PROCESS | 2643 | [#5] yui.html Cycles:180 Average:19061.13 Median:4184.57 stddev:28121.02 (672.0%) stddev-sans-first:28165.88 18:08:56 INFO - PROCESS | 2643 | Values: 639.3 651.4 662.8 680.2 699.3 13234.3 13778.4 14410.0 14437.9 14442.6 14655.1 15368.0 15422.5 15427.7 15430.3 623.9 756.7 781.2 784.5 785.0 640.5 648.7 649.4 649.6 742.4 804.8 805.6 813.8 814.8 815.3 803.5 806.6 806.8 807.0 807.3 478.2 575.2 592.1 592.1 592.9 13599.4 13627.1 13639.4 13661.4 13672.9 12354.8 12436.9 12489.2 12655.4 13283.6 11510.2 11579.8 11641.4 11788.6 12023.8 3955.3 4048.2 4056.6 4105.0 4133.5 64953.7 66454.7 67864.3 67983.3 68267.7 9864.4 10316.8 10382.9 10394.5 10695.1 18744.7 18957.2 19085.3 19086.5 19094.0 6765.0 7190.6 7304.3 7328.4 7352.5 3770.7 3801.8 3853.3 3947.5 3948.5 2717.1 2839.7 2850.4 2850.8 2852.5 486.7 488.0 489.4 497.1 511.4 571.3 607.8 623.8 626.3 630.1 7922.7 8207.2 8436.7 8867.9 8917.5 580.7 583.2 587.7 594.4 610.8 4092.9 4109.3 4150.4 4218.7 4345.4 107052.5 107726.0 108893.0 110300.0 112380.4 90097.0 93216.5 93743.5 94065.5 94546.0 76452.0 78768.6 78950.2 80858.6 83498.6 7911.5 8205.8 8352.6 8462.3 8482.7 47986.5 48779.5 49582.5 49885.3 50847.7 66306.0 66720.0 73258.6 73509.3 73861.6 9783.8 10185.5 10244.7 10315.2 10384.7 10761.5 10818.0 10855.7 11160.1 11524.5 10688.7 10753.2 10984.2 11412.5 11520.7 10119.1 10125.8 10305.4 10560.2 10621.2 10986.8 11913.5 12149.1 12184.1 12367.4 10165.4 10247.0 10368.8 10382.9 10667.5 10184.0 10355.4 10568.0 10586.9 10596.5 18:08:56 INFO - PROCESS | 2643 | -------- Summary: end -------- 18:08:56 INFO - PROCESS | 2643 | 18:08:57 INFO - TEST-INFO | 2643: exit 0 18:08:57 INFO - TEST-OK | dromaeo_css | took 1120310ms 18:08:57 INFO - TEST-START | kraken 18:08:57 INFO - operating with platform_type : linux_ 18:08:57 INFO - Initialising browser for kraken test... 18:08:57 INFO - TEST-INFO | started process 2939 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplMf6Z7/profile http://localhost:36434/getInfo.html) 18:09:01 INFO - PROCESS | 2939 | __metrics Screen width/height:1600/1200 18:09:01 INFO - PROCESS | 2939 | colorDepth:24 18:09:01 INFO - PROCESS | 2939 | Browser inner width/height: 1024/697 18:09:01 INFO - PROCESS | 2939 | __metrics 18:09:02 INFO - PROCESS | 2939 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:09:02 INFO - PROCESS | 2939 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:09:03 INFO - TEST-INFO | 2939: exit 0 18:09:03 INFO - Browser initialized. 18:09:03 INFO - Running cycle 1/1 for kraken test... 18:09:03 INFO - TEST-INFO | started process 3021 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplMf6Z7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:09:15 INFO - PROCESS | 3021 | RSS: Main: 157450240 18:09:15 INFO - PROCESS | 3021 | 18:09:17 INFO - PROCESS | 3021 | Cycle 1(1): loaded http://localhost:36434/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36434/tests/kraken/driver.html?testName=audio-beat-detection) 18:09:18 INFO - PROCESS | 3021 | RSS: Main: 213434368 18:09:18 INFO - PROCESS | 3021 | 18:09:21 INFO - PROCESS | 3021 | Cycle 1(1): loaded http://localhost:36434/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36434/tests/kraken/driver.html?testName=audio-dft) 18:09:22 INFO - PROCESS | 3021 | RSS: Main: 191291392 18:09:22 INFO - PROCESS | 3021 | 18:09:25 INFO - PROCESS | 3021 | Cycle 1(1): loaded http://localhost:36434/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36434/tests/kraken/driver.html?testName=audio-fft) 18:09:26 INFO - PROCESS | 3021 | RSS: Main: 271065088 18:09:26 INFO - PROCESS | 3021 | 18:09:28 INFO - PROCESS | 3021 | Cycle 1(1): loaded http://localhost:36434/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36434/tests/kraken/driver.html?testName=audio-oscillator) 18:09:28 INFO - PROCESS | 3021 | RSS: Main: 180879360 18:09:28 INFO - PROCESS | 3021 | 18:09:31 INFO - PROCESS | 3021 | Cycle 1(1): loaded http://localhost:36434/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36434/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:09:31 INFO - PROCESS | 3021 | RSS: Main: 184348672 18:09:31 INFO - PROCESS | 3021 | 18:09:34 INFO - PROCESS | 3021 | Cycle 1(1): loaded http://localhost:36434/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36434/tests/kraken/driver.html?testName=imaging-darkroom) 18:09:35 INFO - PROCESS | 3021 | RSS: Main: 221315072 18:09:35 INFO - PROCESS | 3021 | 18:09:39 INFO - PROCESS | 3021 | Cycle 1(1): loaded http://localhost:36434/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36434/tests/kraken/driver.html?testName=imaging-desaturate) 18:09:39 INFO - PROCESS | 3021 | RSS: Main: 219660288 18:09:39 INFO - PROCESS | 3021 | 18:09:42 INFO - PROCESS | 3021 | Cycle 1(1): loaded http://localhost:36434/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36434/tests/kraken/driver.html?testName=json-parse-financial) 18:09:43 INFO - PROCESS | 3021 | RSS: Main: 219648000 18:09:43 INFO - PROCESS | 3021 | 18:09:44 INFO - PROCESS | 3021 | Cycle 1(1): loaded http://localhost:36434/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36434/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:09:45 INFO - PROCESS | 3021 | RSS: Main: 184844288 18:09:45 INFO - PROCESS | 3021 | 18:09:47 INFO - PROCESS | 3021 | Cycle 1(1): loaded http://localhost:36434/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36434/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:09:48 INFO - PROCESS | 3021 | RSS: Main: 189800448 18:09:48 INFO - PROCESS | 3021 | 18:09:50 INFO - PROCESS | 3021 | Cycle 1(1): loaded http://localhost:36434/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36434/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:09:50 INFO - PROCESS | 3021 | RSS: Main: 194015232 18:09:50 INFO - PROCESS | 3021 | 18:09:53 INFO - PROCESS | 3021 | Cycle 1(1): loaded http://localhost:36434/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36434/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:09:54 INFO - PROCESS | 3021 | RSS: Main: 189255680 18:09:54 INFO - PROCESS | 3021 | 18:09:57 INFO - PROCESS | 3021 | Cycle 1(1): loaded http://localhost:36434/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36434/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:09:57 INFO - PROCESS | 3021 | RSS: Main: 192319488 18:09:57 INFO - PROCESS | 3021 | 18:09:59 INFO - PROCESS | 3021 | Cycle 1(1): loaded http://localhost:36434/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36434/tests/kraken/driver.html?testName=ai-astar) 18:09:59 INFO - PROCESS | 3021 | RSS: Main: 242429952 18:09:59 INFO - PROCESS | 3021 | 18:09:59 INFO - PROCESS | 3021 | __start_tp_report 18:09:59 INFO - PROCESS | 3021 | _x_x_mozilla_page_load 18:09:59 INFO - PROCESS | 3021 | _x_x_mozilla_page_load_details 18:09:59 INFO - PROCESS | 3021 | |i|pagename|runs| 18:09:59 INFO - PROCESS | 3021 | |0;ai-astar;103;114;114;114;113;115;113;114;116;114 18:09:59 INFO - PROCESS | 3021 | |1;audio-beat-detection;154;122;122;187;123;125;147;123;178;126 18:09:59 INFO - PROCESS | 3021 | |2;audio-dft;162;160;160;162;161;162;162;160;161;161 18:09:59 INFO - PROCESS | 3021 | |3;audio-fft;76;77;76;120;77;77;74;77;129;75 18:09:59 INFO - PROCESS | 3021 | |4;audio-oscillator;86;85;132;85;86;85;121;85;85;128 18:09:59 INFO - PROCESS | 3021 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;116;117;117 18:09:59 INFO - PROCESS | 3021 | |6;imaging-darkroom;147;146;148;148;146;147;148;147;147;146 18:09:59 INFO - PROCESS | 3021 | |7;imaging-desaturate;95;94;95;95;95;95;94;95;95;95 18:09:59 INFO - PROCESS | 3021 | |8;json-parse-financial;64;62;63;62;62;64;62;61;62;62 18:09:59 INFO - PROCESS | 3021 | |9;json-stringify-tinderbox;65;66;66;67;67;65;66;66;65;65 18:09:59 INFO - PROCESS | 3021 | |10;stanford-crypto-aes;80;80;80;82;80;79;80;84;79;86 18:09:59 INFO - PROCESS | 3021 | |11;stanford-crypto-ccm;133;132;138;129;131;129;137;130;144;132 18:09:59 INFO - PROCESS | 3021 | |12;stanford-crypto-pbkdf2;169;170;166;166;165;168;170;166;170;167 18:09:59 INFO - PROCESS | 3021 | |13;stanford-crypto-sha256-iterative;69;67;68;68;67;68;69;66;66;66 18:09:59 INFO - PROCESS | 3021 | __end_tp_report 18:09:59 INFO - PROCESS | 3021 | __start_cc_report 18:09:59 INFO - PROCESS | 3021 | _x_x_mozilla_cycle_collect,1962 18:09:59 INFO - PROCESS | 3021 | __end_cc_report 18:09:59 INFO - PROCESS | 3021 | __startTimestamp1470877799726__endTimestamp 18:09:59 INFO - PROCESS | 3021 | 18:09:59 INFO - PROCESS | 3021 | ------- Summary: start ------- 18:09:59 INFO - PROCESS | 3021 | Number of tests: 14 18:09:59 INFO - PROCESS | 3021 | 18:09:59 INFO - PROCESS | 3021 | [#0] ai-astar Cycles:10 Average:113.00 Median:114.00 stddev:3.62 (3.2%) stddev-sans-first:0.93 18:09:59 INFO - PROCESS | 3021 | Values: 103.0 114.0 114.0 114.0 113.0 115.0 113.0 114.0 116.0 114.0 18:09:59 INFO - PROCESS | 3021 | 18:09:59 INFO - PROCESS | 3021 | [#1] audio-beat-detection Cycles:10 Average:140.70 Median:136.50 stddev:24.81 (18.2%) stddev-sans-first:25.84 18:09:59 INFO - PROCESS | 3021 | Values: 154.0 122.0 122.0 187.0 123.0 125.0 147.0 123.0 178.0 126.0 18:09:59 INFO - PROCESS | 3021 | 18:09:59 INFO - PROCESS | 3021 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:0.88 (0.5%) stddev-sans-first:0.87 18:09:59 INFO - PROCESS | 3021 | Values: 162.0 160.0 160.0 162.0 161.0 162.0 162.0 160.0 161.0 161.0 18:09:59 INFO - PROCESS | 3021 | 18:09:59 INFO - PROCESS | 3021 | [#3] audio-fft Cycles:10 Average:85.80 Median:76.50 stddev:20.53 (26.8%) stddev-sans-first:21.47 18:09:59 INFO - PROCESS | 3021 | Values: 76.0 77.0 76.0 120.0 77.0 77.0 74.0 77.0 129.0 75.0 18:09:59 INFO - PROCESS | 3021 | 18:09:59 INFO - PROCESS | 3021 | [#4] audio-oscillator Cycles:10 Average:97.80 Median:85.00 stddev:20.32 (23.9%) stddev-sans-first:21.10 18:09:59 INFO - PROCESS | 3021 | Values: 86.0 85.0 132.0 85.0 86.0 85.0 121.0 85.0 85.0 128.0 18:09:59 INFO - PROCESS | 3021 | 18:09:59 INFO - PROCESS | 3021 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 18:09:59 INFO - PROCESS | 3021 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 18:09:59 INFO - PROCESS | 3021 | 18:09:59 INFO - PROCESS | 3021 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 18:09:59 INFO - PROCESS | 3021 | Values: 147.0 146.0 148.0 148.0 146.0 147.0 148.0 147.0 147.0 146.0 18:09:59 INFO - PROCESS | 3021 | 18:09:59 INFO - PROCESS | 3021 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 18:09:59 INFO - PROCESS | 3021 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 18:09:59 INFO - PROCESS | 3021 | 18:09:59 INFO - PROCESS | 3021 | [#8] json-parse-financial Cycles:10 Average:62.40 Median:62.00 stddev:0.97 (1.6%) stddev-sans-first:0.83 18:09:59 INFO - PROCESS | 3021 | Values: 64.0 62.0 63.0 62.0 62.0 64.0 62.0 61.0 62.0 62.0 18:09:59 INFO - PROCESS | 3021 | 18:09:59 INFO - PROCESS | 3021 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:0.79 (1.2%) stddev-sans-first:0.78 18:09:59 INFO - PROCESS | 3021 | Values: 65.0 66.0 66.0 67.0 67.0 65.0 66.0 66.0 65.0 65.0 18:09:59 INFO - PROCESS | 3021 | 18:09:59 INFO - PROCESS | 3021 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:80.00 stddev:2.31 (2.9%) stddev-sans-first:2.42 18:09:59 INFO - PROCESS | 3021 | Values: 80.0 80.0 80.0 82.0 80.0 79.0 80.0 84.0 79.0 86.0 18:09:59 INFO - PROCESS | 3021 | 18:09:59 INFO - PROCESS | 3021 | [#11] stanford-crypto-ccm Cycles:10 Average:133.50 Median:132.50 stddev:4.79 (3.6%) stddev-sans-first:5.08 18:09:59 INFO - PROCESS | 3021 | Values: 133.0 132.0 138.0 129.0 131.0 129.0 137.0 130.0 144.0 132.0 18:09:59 INFO - PROCESS | 3021 | 18:09:59 INFO - PROCESS | 3021 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.70 Median:168.50 stddev:1.95 (1.2%) stddev-sans-first:2.01 18:09:59 INFO - PROCESS | 3021 | Values: 169.0 170.0 166.0 166.0 165.0 168.0 170.0 166.0 170.0 167.0 18:09:59 INFO - PROCESS | 3021 | 18:09:59 INFO - PROCESS | 3021 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:68.00 stddev:1.17 (1.7%) stddev-sans-first:1.09 18:09:59 INFO - PROCESS | 3021 | Values: 69.0 67.0 68.0 68.0 67.0 68.0 69.0 66.0 66.0 66.0 18:09:59 INFO - PROCESS | 3021 | -------- Summary: end -------- 18:09:59 INFO - PROCESS | 3021 | 18:10:00 INFO - TEST-INFO | 3021: exit 0 18:10:00 INFO - TEST-OK | kraken | took 63454ms 18:10:00 INFO - SUITE-END | took 1183s 18:10:00 INFO - Completed test suite (00:19:43) 18:10:00 INFO - javascript benchmark 18:10:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2642.2469596165092, 2648.523265812153, 2680.892764289429, 2695.7304269573033, 2701.5677491601346, 4575.565321294472, 4673.976630116853, 4762.571368576828, 4873.5613794758465, 4891.584215341701, 4712.505186955372, 4732.692374995623, 4749.8812529686775, 4777.593904518111, 4807.062622788558, 4375.453068366454, 4411.338299255105, 4428.424304840366, 4441.911161776762, 4518.638508919278, 4354.629856462205, 4474.440694913136, 4509.0, 4514.0746147039945, 4555.612772914306, 4239.0674051708575, 4307.224699554079, 4444.73331600105, 4445.73325600465, 4502.369668246448, 4319.308910574293, 4374.934375984363, 4391.363252328394, 4421.801018954155, 4459.2865141577195, 4372.060007098457, 4398.450193725785, 4400.801963911632, 4436.955630443719, 4441.0, 4606.884827879297, 4787.904241915177, 4832.1543729847135, 4834.468208497063, 4848.46666866648, 5060.721660308682, 5151.66514176581, 5153.665011774223, 5243.318368612094, 5245.0, 5258.92111618326, 5264.052470555299, 5265.21021846726, 5273.050850846846, 5274.05067087924, 4625.953740462553, 4904.975475122602, 4914.508549145057, 4921.876953076202, 4922.089413458521, 5226.947730522646, 5249.527542521191, 5270.525652691276, 5336.386315573681, 5369.946300537023, 5059.645824792303, 5108.106081435734, 5117.104506711311, 5135.460776618476, 5136.897262054813, 5154.329937108152, 5171.431142574389, 5175.275461435402, 5211.114110601131, 5221.660592061504, 4796.760161991956, 5017.1721665924715, 5061.089003979246, 5094.0, 5105.795768169231, 5158.303629010111, 5162.251473536391, 5163.251328557338, 5174.534291913746, 5214.97392513035, 4394.231009573312, 4442.222611043055, 4448.5551444855255, 4484.327350897326, 4492.460904691458, 3724.2179142380405, 3728.9440658390145, 3811.294910441577, 3812.5996770338716, 3873.845046198177, 4418.8453404130705, 4447.688661793643, 4453.1761624099645, 4491.393661855673, 4491.618212451978, 5225.399079105951, 5232.189010703347, 5232.39827419844, 5233.659812112277, 5283.260343551906, 4167.354060120626, 4368.235558777201, 4442.622377097919, 4450.06548624786, 4498.190325741332, 4570.085982803453, 4611.538846115429, 4630.282306242538, 4643.883902902455, 4646.372739680168, 4736.052789442194, 4786.8085276589245, 4789.808407663654, 4793.113274044313, 4828.613710903049, 4920.434150072788, 5095.210242412432, 5109.565686916654, 5112.590992720648, 5158.613104017289, 4735.857924262277, 4738.407699037621, 4739.360186374795, 4755.0, 4813.229883218668, 5028.094942910311, 5047.949520504748, 5049.84850454487, 5053.469385714594, 5109.565686916654, 4874.171390863491, 5058.64589478733, 5068.873278168076, 5072.340595722532, 5121.564667003197, 4890.413150421972, 4943.703377797344, 5009.0482808266315, 5039.067772462106, 5063.645544811975, 5015.5987520997505, 5027.673201241908, 5028.472010438997, 5036.143855544493, 5075.822346218012, 4640.651951103749, 4938.259261110718, 4954.653174277766, 4987.850364489072, 4999.125153098266, 4972.254161875748, 5020.3724534433195, 5035.949640503548, 5078.9238161426865, 5103.8468845934685, 4950.628702847373, 4959.330490383752, 4959.504049595012, 4961.404631444249, 5010.248462730474], "value": 4717.8153786677, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.2576586023519, 567.1606023085833, 570.9800156994503, 573.9167820666004, 587.8677297608042, 28469.57295640567, 41830.79084604576, 42830.35754463682, 42875.78562107185, 42981.57018429815, 40105.7994710026, 40298.59701402985, 40506.18987620246, 40528.39207411884, 40533.0, 7697.499662521946, 7869.449138560274, 7870.409719271078, 7873.330766884822, 7882.921170788276, 7699.34555562775, 7805.843883122334, 7806.0, 7810.80472988177, 7815.0, 7813.257740514642, 7834.0990786059765, 7840.607969601526, 7862.0, 7862.331701805353, 7770.689172433096, 7814.804629884242, 7830.2169783021245, 7839.804004899866, 7841.686332546691, 7568.5458872467825, 7619.885701714424, 7624.809379765495, 7633.313001829806, 7649.196834332426, 37481.43777843335, 37788.62211377879, 37824.62175378238, 37831.0, 37901.0, 3244.4646633305474, 3326.9334613307597, 3440.346334196495, 3579.7673151245085, 3786.488824008751, 28626.284342891387, 29271.121866344045, 29278.707212928024, 29288.853555732298, 29296.56055159174, 3332.4001679697644, 3379.6958273755235, 3394.8811791587423, 3532.2229109595846, 3533.1873669056004, 263085.0, 263561.0, 263631.0, 264379.9999999981, 265689.0, 31437.842810786256, 32291.35417291688, 52662.473375265756, 53100.46899531032, 53211.0, 33400.33199336, 33608.83195584006, 33632.663673363444, 33642.49536256958, 33671.15822104418, 12986.220826750236, 12996.675083122998, 13011.154274972096, 13022.088453808332, 13103.541376051793, 11018.228723989243, 11144.777104458028, 11157.609483668195, 11160.776784464266, 11167.609133680282, 7756.728514501965, 7872.842543149105, 7879.803004924923, 7942.166072562413, 7961.363090952826, 3083.2137804859617, 3086.0777060588325, 3104.7360974317435, 3109.4247564200696, 3186.426443240239, 833.2833762963846, 854.7307598106577, 870.8345414371249, 919.6689191890914, 955.7515046087929, 26722.19833405001, 27960.462174580593, 28393.716062839107, 28778.71221287802, 28977.85511072431, 814.7840822182127, 921.9354645174774, 957.6648173139484, 958.6213445688913, 1089.84742136101, 13952.86047139536, 14733.778993315109, 14863.0, 14996.625084372978, 15110.773338399933, 375255.0, 379657.0, 379996.0, 380711.0, 381746.91265436617, 47132.764336178785, 47559.762201189464, 47627.76186119047, 47659.0, 47737.522624774, 1072.9034386905216, 1158.7914175448332, 1164.976700465986, 1187.4715751490676, 1188.1920294200027, 27766.305842354104, 29036.419271614872, 29106.479931647715, 29346.55980160342, 29717.85141074281, 40883.0, 40918.0, 41225.79387103045, 41389.1722165549, 41417.37873931954, 300370.0, 302556.0, 302962.0, 303173.0, 581470.0, 35519.0, 36278.637213627524, 36298.27403451969, 36518.8174059128, 36903.26193476169, 39418.605813941496, 39603.80198098991, 39936.80031599823, 40108.0, 40362.0, 34021.149471263416, 34170.82914585411, 34560.65439345675, 34667.0, 34894.476582851785, 33762.831185844894, 34119.48820767641, 34435.65564344324, 34607.480887787206, 35460.46809297811, 34043.14892127617, 34282.14294642654, 34361.82819085888, 34670.65329346674, 41180.16008920384, 35051.649483504836, 35171.0, 37255.8137209323, 37452.43821342628, 39307.2138557233, 30780.99159101164, 30808.691913080584, 30821.22946926345, 30854.228644284074, 31011.224719382197], "value": 16706.744163784682, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.1787144688343, 336.46334097115107, 355.81141994742785, 360.5205077247262, 378.70082634718574, 12651.240925544462, 16046.117463539515, 16736.079515626636, 17127.57181070474, 18241.726374104364, 15744.606384840356, 16160.515184544452, 16625.168741562935, 16767.580810479743, 16805.663886722257, 4886.462489126193, 5063.670861394016, 5095.3885533736, 5286.682799032051, 5345.0, 3471.5313432686644, 5025.7235852028125, 5257.8948421031555, 5285.2600635911, 5294.947050529484, 5309.858380448203, 5353.705546194958, 5365.302510673607, 5379.193121031837, 5381.623286369956, 5173.094708426011, 5281.894362112736, 5315.574754019669, 5369.0, 5373.7581808818695, 5169.431362550116, 5172.61205409592, 5176.378834539879, 5183.429822719498, 5194.0, 11899.0, 16487.587810304718, 20612.58774824495, 20648.896755516278, 20839.8958005209, 1820.4902627264387, 1838.7517685112473, 1852.6850435425874, 1919.5009297582728, 1958.921643134273, 12758.36208189596, 13044.673883152902, 13052.477900883954, 13175.407106680223, 13841.30793460323, 1696.9406070787586, 1821.0985562146689, 1834.4496651004645, 1877.1271358818078, 1878.5209771508178, 71909.0, 72681.0, 72695.63652181758, 73125.63437182833, 73355.63322183354, 10030.548625311732, 10199.7450063749, 10322.896771032194, 10393.792124157626, 10593.947030264953, 13892.374843131882, 13898.652533686536, 13912.234827084607, 13936.233507157203, 13940.163590184622, 6967.686454109577, 7271.309225623558, 7312.524685895506, 7393.926060739432, 7447.702091916371, 6904.240533541307, 6928.44572434204, 7132.358087772125, 7163.283671632795, 7180.712771489187, 4254.595813397722, 4344.717593356485, 4356.499002614676, 4453.933191002137, 4472.396226509444, 1739.5216315513082, 1770.97343539847, 1771.5659663382553, 1813.8820976636475, 1828.6616975859508, 800.9038915330198, 821.9876701849477, 886.2156991062827, 889.6263569300779, 898.2409863665192, 16928.661426771396, 17756.20097095608, 17985.0, 18120.456386308433, 18152.27390904349, 832.7252006837729, 839.9244068033906, 849.668629234599, 889.1286539191499, 890.0609856601347, 9377.484238366955, 10046.19630429564, 10079.193664506822, 10082.49587520621, 10172.643957461454, 377237.0, 380318.0, 385897.0, 386043.0, 387180.0, 49730.0, 75592.62203688946, 75720.0, 76872.61563692258, 78639.99999999885, 887.1793590928365, 902.8916530016309, 916.7937214126769, 917.9219766319937, 924.3714274293545, 15208.771868422204, 15725.921370393533, 16119.838801612303, 16344.509664710078, 16440.095794731405, 37149.0, 37282.0, 38146.618533814304, 42229.78885105555, 43159.78420108005, 54660.72669636626, 56515.434845652664, 56544.15183772164, 56654.0, 58384.0, 7390.667419966222, 7586.24137586237, 7685.193054729173, 7858.764237072897, 7995.200479951958, 9601.423914565148, 12166.087543434454, 12179.512819487476, 12783.872161278268, 12868.742625147257, 10247.846282305622, 10481.947590262, 10519.842202366817, 10640.627578034731, 10774.299670521392, 10626.25616206889, 10660.360378377321, 10697.090747286256, 10793.514291857042, 10802.351858888493, 10231.590736370461, 10244.692659220234, 10365.481725913825, 10371.325863818827, 11504.884951150716, 7549.2073332299315, 7632.0, 7688.807779805549, 7983.520988740462, 8048.114707382067, 9241.353105282566, 9961.302708810314, 10068.295219334575, 10134.442605656759, 10407.115395191493], "value": 8289.749762490106, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1246.7755803955297, 1357.8574249703781, 1395.9302034898255, 1452.7021960498098, 1680.6218600814818, 6554.082428460013, 7504.66229019694, 7739.806504837382, 7742.767716968493, 8084.0, 7868.449208555404, 7941.12647608764, 7944.563049032301, 7945.483543569664, 7954.045514538264, 2146.0, 2180.90185941633, 2181.2365672014826, 2181.7818218178136, 2181.9781802182015, 2119.5231073008604, 2169.229923377202, 2194.0, 2200.8679479231296, 2201.0975500044983, 2136.380449669594, 2143.153454385517, 2150.2689085710854, 2151.580441813847, 2199.5820794049077, 2103.852730308879, 2105.6736205888037, 2111.1660893946882, 2111.5565731196466, 2112.049577690038, 2059.7322348094804, 2103.9474013149793, 2104.379208133604, 2106.73665791776, 2108.5782843431375, 7281.490295679305, 7764.961175194087, 7837.921620783776, 7845.725399610987, 7913.9604301978125, 4311.568843115663, 4506.842260520899, 4512.435945506812, 4517.435320584927, 4519.864404067883, 2853.9001134960176, 2950.4541659792794, 3007.7593792496546, 3016.9547456788164, 3024.6219222597174, 947.3747326764371, 952.4095061062186, 965.097633712474, 984.3208186351395, 993.8707967964191, 10586.41774702391, 10588.788224235472, 10675.626353077605, 10695.679129626124, 10695.732606684895, 3803.3534299168655, 3914.197589494147, 3954.8022598869943, 4033.092554175346, 4044.3326851069833, 8363.832723345498, 8485.490870547786, 8489.4481858679, 8506.702265420681, 8518.403711740242, 4420.447444069491, 4427.026054268056, 4428.0, 4429.313456414261, 4435.2016637005, 3334.333133373335, 3583.480395342661, 3718.761911277467, 4126.360414135814, 4130.380442933524, 3189.5694081299193, 3286.2277364819247, 3363.3273345330545, 3367.7642565020215, 3435.5362026126654, 961.697065424389, 968.7529679931572, 969.5976169889417, 970.7912798748303, 977.7946631207384, 796.4783067091065, 797.1709422200962, 804.2359758229705, 817.7710241132493, 820.2535692519779, 4932.802687892444, 5124.5131712487255, 5140.56305214061, 5146.948530514722, 5194.337991715831, 353.41333386578157, 355.0661759572308, 356.939320315547, 361.5011284427526, 366.4137380191725, 3567.108222944264, 3649.5802982656805, 3680.0799800049986, 3695.2240029594086, 3746.6066063062985, 9430.905690943002, 9861.901380986243, 9897.0, 9915.0, 9915.702528924145, 8843.955780221058, 9731.805363892683, 9757.609695612096, 9770.462624555576, 9785.315027948118, 7050.506464547432, 7348.77953661391, 7357.742479013209, 7371.6682749276415, 7391.260873912565, 5320.5477534408465, 5530.419305972815, 5550.0, 5604.103343465026, 5662.499437649109, 8581.742547723577, 8688.30493560501, 8826.161514656098, 8956.955215224143, 8958.10418958099, 8937.195652391316, 9042.593083311136, 9133.634654614007, 9188.678396256098, 9217.723468295962, 6865.622390768555, 7023.613701246276, 7034.824129396806, 7039.54242974205, 7045.436365090883, 7259.818504537428, 7323.7436689715605, 7329.706811727471, 7450.776476705708, 7538.811529711801, 6814.522983391115, 6852.8286792828585, 6901.723931042702, 6911.827204319731, 6944.340287672663, 6554.8361290966195, 6639.236487803964, 6688.130543029375, 6812.489063320171, 6832.180138383425, 6381.3937675920715, 6483.448906842783, 6485.0, 6485.221773387224, 6488.026795980451, 4567.086582683411, 4634.32802243666, 4669.252919532859, 4719.244920812654, 4751.904961900674, 4647.721136731807, 4658.20810462229, 4703.365045718784, 4746.406699162605, 4951.455339912534], "value": 3986.012174317071, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [280.3975281267557, 287.7582830422445, 297.89126968656444, 298.5640964192279, 299.6060180862167, 4864.927026094607, 4895.192293271611, 4907.497176440014, 4912.7297998610065, 4975.776090075946, 4629.421322334708, 4686.718796872182, 4738.6446016548725, 4805.399325084364, 4872.415310162785, 3805.809709514513, 3818.885433437001, 3821.8853434396874, 3826.215625796719, 3842.8270727817317, 3811.8856434306877, 3822.7706337619693, 3842.769433833979, 3855.3350445960423, 3864.3237433449176, 3608.6932610728118, 3672.797996110213, 3782.9621703783023, 3796.335641262782, 3796.7721936683747, 3786.6213378662187, 3804.733668643196, 3821.48409964654, 3822.6559609635265, 3832.7891965941863, 3365.4278772608473, 3367.2760356523463, 3367.7810942288675, 3370.7640465167447, 3379.2227787608986, 4475.597196252353, 4729.888476208088, 4760.0, 4797.40032495938, 4803.855884323476, 4174.519930208005, 4202.781193453895, 4203.372891942536, 4207.431996680471, 4231.513375961773, 5015.498450154992, 5016.77424515894, 5028.472010438888, 5063.215201643714, 5071.898562028776, 3539.752217344787, 3561.1631266652316, 3567.1973805893726, 3572.3034008368377, 3575.3564358415474, 5059.999999999964, 5268.49847793377, 5278.340207474066, 5303.761330740087, 5316.282301889234, 3585.4980302757635, 3615.9096022599647, 3622.2574372253625, 3627.3289441453417, 3630.981845090758, 3699.2601479704167, 3699.3537875645616, 3710.981445092811, 3715.2198038412234, 3717.9070523237137, 4194.370844373308, 4285.821399115268, 4285.892852678708, 4293.184294983943, 4333.0, 4965.577925876269, 4976.651634385631, 5021.799128034911, 5033.597312215014, 5036.194208926628, 1271.7536813922409, 1311.141202512356, 1311.3639884655934, 1327.1373607155233, 1327.6614463311794, 841.4908980067094, 852.9275011624081, 874.7987962768599, 881.7090360181124, 883.3992884838372, 4341.544137865541, 4341.891452713708, 4483.94627262593, 4486.842960496367, 4487.528809475023, 5216.321878155892, 5218.191180366974, 5222.764975576109, 5251.2123181523075, 5254.448282930313, 4269.380939763717, 4478.731276123443, 4482.28283474649, 4513.796879140446, 4520.118576877478, 2757.6828664703417, 2799.768102035098, 2801.817881837674, 2802.215379693689, 2803.2431243564124, 4969.3291405659775, 4970.527799859007, 4978.0, 4996.300517927493, 5000.599952003831, 5086.516780905808, 5346.679199247979, 5380.542653874386, 5415.702136382458, 5424.349078110652, 4930.334404855299, 4934.458753741826, 4942.75286235694, 4951.925721114186, 4955.40535135786, 5237.554807841376, 5243.318368612056, 5253.947460525499, 5255.264263003259, 5268.1834315681135, 4912.508749125059, 5142.6914385137015, 5158.045761534128, 5159.716215608178, 5210.645232239721, 4923.852284431473, 4926.975365123151, 4928.29973659087, 4934.136526107988, 4941.33292005589, 3651.141981634261, 3686.170611612473, 3744.8876533704033, 3746.981265093657, 3747.812609369466, 5194.96100779838, 5254.605904557097, 5267.7366131694025, 5291.8677033072945, 5351.224072509543, 5066.138756411346, 5074.695518268915, 5089.0, 5093.638198788782, 5103.260027296095, 5030.874228144326, 5106.693598384109, 5106.923396148986, 5122.359705036871, 5138.203578445347, 4844.685095468783, 4955.479674634112, 4974.7512624369365, 4982.252662100714, 5001.599872010303, 4867.805287788448, 4917.852464426073, 5101.897962040813, 5106.8509585343, 5114.3862736471865, 5016.598672106295, 5018.397792264952, 5076.11168045598, 5080.872978175576, 5089.567386772166], "value": 3824.63081901498, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [639.335091504835, 651.4365074210809, 662.7647185249233, 680.244928129776, 699.3076853914625, 13234.338283085843, 13778.379972901219, 14410.0, 14437.855621443783, 14442.638934026654, 14655.120692758443, 15368.0, 15422.460213892487, 15427.69144617107, 15430.305636246369, 623.9188905442286, 756.6859753202428, 781.2304879693497, 784.4900814470583, 785.0148064179475, 640.5068097564872, 648.6659370424235, 649.3701109923367, 649.5680372552247, 742.4320394897908, 804.7545498622918, 805.5609692717483, 813.7762115418249, 814.7596459044566, 815.2621877201112, 803.4817542684993, 806.6249194124731, 806.8305655812286, 807.0114110214998, 807.2532907060945, 478.15128147538053, 575.2320651929679, 592.0793166625895, 592.0822724776579, 592.943670351316, 13599.388027538784, 13627.114237574526, 13639.386227619781, 13661.385237664328, 13672.863271367258, 12354.75290494185, 12436.937815310956, 12489.188202766882, 12655.367231638473, 13283.601491955256, 11510.194286399956, 11579.826302605383, 11641.41792910351, 11788.587399441065, 12023.759524809542, 3955.268275369066, 4048.210598933209, 4056.553779084298, 4105.035316700573, 4133.46264985553, 64953.675231623536, 66454.66772666202, 67864.3213567868, 67983.32016679869, 68267.65866170687, 9864.358816676893, 10316.845247321296, 10382.948085259526, 10394.48027598617, 10695.144388448905, 18744.718829217574, 18957.24171033171, 19085.332013379466, 19086.52283692891, 19094.0, 6765.0, 7190.604516751629, 7304.306090921354, 7328.413726901835, 7352.5220860643885, 3770.7171962102952, 3801.790901500389, 3853.325668008087, 3947.4868267125667, 3948.506436695413, 2717.0761940940174, 2839.7444230019396, 2850.372917958046, 2850.7719382449354, 2852.5150724376904, 486.7055431463984, 487.9634027447956, 489.4053724724477, 497.07295893159, 511.43486447475004, 571.2602180176681, 607.781198768443, 623.8066199478086, 626.2985456288985, 630.0989584893646, 7922.683092676343, 8207.220314070273, 8436.704715335056, 8867.91132088671, 8917.464952102764, 580.7415700013538, 583.174807647183, 587.6767777722235, 594.4441946779775, 610.7709608896664, 4092.8567500137947, 4109.3425051991535, 4150.398192262105, 4218.7468751874985, 4345.3699213613845, 107052.5221681252, 107726.0, 108893.0, 110300.0, 112380.43809780899, 90097.0, 93216.53391732997, 93743.53128234314, 94065.52967235257, 94546.0, 76452.0, 78768.60615696885, 78950.21049789543, 80858.59570702109, 83498.58250708708, 7911.525308481279, 8205.753827385188, 8352.58237088131, 8462.280706140047, 8482.703105391281, 47986.52013479821, 48779.512204877494, 49582.50417495779, 49885.25172122494, 50847.74576127244, 66306.0, 66720.0, 73258.63370683113, 73509.26490735238, 73861.63069184619, 9783.804323913624, 10185.49072546355, 10244.692659220234, 10315.226358023028, 10384.74038149022, 10761.515731792244, 10818.0, 10855.67432977012, 11160.10719142483, 11524.481398336928, 10688.73278168021, 10753.193510486588, 10984.231103822656, 11412.48643811047, 11520.711982200512, 10119.139873110867, 10125.848112278174, 10305.381677099398, 10560.155187584822, 10621.15030797519, 10986.780264394507, 11913.463894124958, 12149.149559530748, 12184.086193535697, 12367.396133196624, 10165.390076595428, 10246.957981178635, 10368.792624147625, 10382.90320490137, 10667.51996160159, 10184.0, 10355.361163180605, 10568.0, 10586.947065264625, 10596.47017649099], "value": 6703.126332834139, "unit": "score"}], "name": "dromaeo_css", "value": 6369.490950200628, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 114.0, 114.0, 113.0, 115.0, 113.0, 114.0, 116.0, 114.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 122.0, 122.0, 187.0, 123.0, 125.0, 147.0, 123.0, 178.0, 126.0], "value": 140.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 160.0, 162.0, 161.0, 162.0, 162.0, 160.0, 161.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 120.0, 77.0, 77.0, 74.0, 77.0, 129.0, 75.0], "value": 85.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 132.0, 85.0, 86.0, 85.0, 121.0, 85.0, 85.0, 128.0], "value": 97.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 148.0, 148.0, 146.0, 147.0, 148.0, 147.0, 147.0, 146.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 63.0, 62.0, 62.0, 64.0, 62.0, 61.0, 62.0, 62.0], "value": 62.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 67.0, 67.0, 65.0, 66.0, 66.0, 65.0, 65.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 80.0, 82.0, 80.0, 79.0, 80.0, 84.0, 79.0, 86.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 132.0, 138.0, 129.0, 131.0, 129.0, 137.0, 130.0, 144.0, 132.0], "value": 133.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 170.0, 166.0, 166.0, 165.0, 168.0, 170.0, 166.0, 170.0, 167.0], "value": 167.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 68.0, 68.0, 67.0, 68.0, 69.0, 66.0, 66.0, 66.0], "value": 67.4, "unit": "score"}], "name": "kraken", "value": 1534.9, "alertThreshold": 2.0}]} 18:10:00 INFO - Return code: 0 18:10:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:10:01 INFO - # TBPL SUCCESS # 18:10:01 INFO - Running post-action listener: _resource_record_post_action 18:10:01 INFO - [mozharness: 2016-08-11 01:10:01.031331Z] Finished run-tests step (success) 18:10:01 INFO - Running post-run listener: _resource_record_post_run 18:10:01 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 532852736; Read time: 12; Write time: 441540 18:10:01 INFO - TinderboxPrint: CPU usage
13.0% 18:10:01 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 18:10:01 INFO - TinderboxPrint: I/O write bytes / time
532,852,736 / 441,540 18:10:01 INFO - TinderboxPrint: CPU idle
8,335.3 (87.0%) 18:10:01 INFO - TinderboxPrint: CPU user
1,198.8 (12.5%) 18:10:01 INFO - TinderboxPrint: Swap in / out
0 / 0 18:10:01 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 248205312; Read time: 0; Write time: 260604 18:10:01 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 284647424; Read time: 0; Write time: 180936 18:10:01 INFO - Running post-run listener: _upload_blobber_files 18:10:01 INFO - Blob upload gear active. 18:10:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:10:01 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:10:01 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:10:01 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:10:02 INFO - (blobuploader) - INFO - Open directory for files ... 18:10:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:10:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:10:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:10:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:10:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:10:02 INFO - (blobuploader) - INFO - Done attempting. 18:10:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:10:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:10:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:10:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:10:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:10:09 INFO - (blobuploader) - INFO - Done attempting. 18:10:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:10:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:10:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:10:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:10:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:10:10 INFO - (blobuploader) - INFO - Done attempting. 18:10:10 INFO - (blobuploader) - INFO - Iteration through files over. 18:10:10 INFO - Return code: 0 18:10:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:10:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:10:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ee6a38cb661fcc8684ecd58364e38b9d64141edf5c59b7285654d8a117ecbfa02176153d5821f94ae69d7aa2e38bf74c982db7d5a48718676ccc1aba40b18706", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e82c1bb388a4449055d296b2a48fca6fd607654844ed39c982a8cdc4ec3b1b8eb5ab3ab446225bc79519ecf2237665d80c11128e2c013895bd8cfd91f16e2494", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/efd2e147aa9f4629281e818310730365aa04784784057cf194e033ba782d4daa9e894613e2a7d009c52b3d3058500f95247adacc317f88baf2405a7eff4c9549"} 18:10:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:10:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:10:10 INFO - Contents: 18:10:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ee6a38cb661fcc8684ecd58364e38b9d64141edf5c59b7285654d8a117ecbfa02176153d5821f94ae69d7aa2e38bf74c982db7d5a48718676ccc1aba40b18706", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e82c1bb388a4449055d296b2a48fca6fd607654844ed39c982a8cdc4ec3b1b8eb5ab3ab446225bc79519ecf2237665d80c11128e2c013895bd8cfd91f16e2494", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/efd2e147aa9f4629281e818310730365aa04784784057cf194e033ba782d4daa9e894613e2a7d009c52b3d3058500f95247adacc317f88baf2405a7eff4c9549"} 18:10:10 INFO - Running post-run listener: copy_logs_to_upload_dir 18:10:10 INFO - Copying logs to upload dir... 18:10:10 INFO - mkdir: /builds/slave/test/build/upload/logs 18:10:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.976421 ========= master_lag: 0.16 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-08-10 18:10:10.160008) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-10 18:10:10.167744) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1470876422.207024-630820636 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-Non-PGO/sha512/ee6a38cb661fcc8684ecd58364e38b9d64141edf5c59b7285654d8a117ecbfa02176153d5821f94ae69d7aa2e38bf74c982db7d5a48718676ccc1aba40b18706", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e82c1bb388a4449055d296b2a48fca6fd607654844ed39c982a8cdc4ec3b1b8eb5ab3ab446225bc79519ecf2237665d80c11128e2c013895bd8cfd91f16e2494", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/efd2e147aa9f4629281e818310730365aa04784784057cf194e033ba782d4daa9e894613e2a7d009c52b3d3058500f95247adacc317f88baf2405a7eff4c9549"} build_url:https://queue.taskcluster.net/v1/task/Li5VGSHDR5GlxAyDGycIcA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010292 build_url: 'https://queue.taskcluster.net/v1/task/Li5VGSHDR5GlxAyDGycIcA/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-Non-PGO/sha512/ee6a38cb661fcc8684ecd58364e38b9d64141edf5c59b7285654d8a117ecbfa02176153d5821f94ae69d7aa2e38bf74c982db7d5a48718676ccc1aba40b18706", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e82c1bb388a4449055d296b2a48fca6fd607654844ed39c982a8cdc4ec3b1b8eb5ab3ab446225bc79519ecf2237665d80c11128e2c013895bd8cfd91f16e2494", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/efd2e147aa9f4629281e818310730365aa04784784057cf194e033ba782d4daa9e894613e2a7d009c52b3d3058500f95247adacc317f88baf2405a7eff4c9549"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-10 18:10:10.192628) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 18:10:10.192932) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1470876422.207024-630820636 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004556 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 18:10:10.242054) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-10 18:10:10.245394) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-10 18:10:10.245696) ========= ========= Total master_lag: 0.28 =========