builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-020 starttime: 1471990335.07 results: success (0) buildid: 20160823135114 builduid: bc0d5fcf32bb4eec82bf76526eb0965d revision: ca24710db69ad1b51f415889a6276a53bc59d36c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-23 15:12:15.066997) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-23 15:12:15.067546) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-23 15:12:15.067909) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-23 15:12:15.083019) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 15:12:15.083415) ========= 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=af724c981e2a0f424dbabf99000001e7-1471990334.421674-1947986402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-23 15:12:15-- 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% 27.5M=0s 2016-08-23 15:12:15 (27.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100539 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 15:12:15.198742) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 15:12:15.199118) ========= 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=af724c981e2a0f424dbabf99000001e7-1471990334.421674-1947986402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019766 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 15:12:15.251684) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 15:12:15.252545) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ca24710db69ad1b51f415889a6276a53bc59d36c --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 ca24710db69ad1b51f415889a6276a53bc59d36c --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=af724c981e2a0f424dbabf99000001e7-1471990334.421674-1947986402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-23 15:12:15,406 truncating revision to first 12 chars 2016-08-23 15:12:15,406 Setting DEBUG logging. 2016-08-23 15:12:15,406 attempt 1/10 2016-08-23 15:12:15,406 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ca24710db69a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-23 15:12:15,732 unpacking tar archive at: mozilla-central-ca24710db69a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.670620 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 15:12:15.940244) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-23 15:12:15.940864) ========= script_repo_revision: ca24710db69ad1b51f415889a6276a53bc59d36c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-23 15:12:15.941336) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-23 15:12:15.941645) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-23 15:12:15.952182) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-08-23 15:12:15.952501) ========= /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=af724c981e2a0f424dbabf99000001e7-1471990334.421674-1947986402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:12:16 INFO - MultiFileLogger online at 20160823 15:12:16 in /builds/slave/test 15:12:16 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 15:12:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:12:16 INFO - {'append_to_log': False, 15:12:16 INFO - 'base_work_dir': '/builds/slave/test', 15:12:16 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:12:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:12:16 INFO - 'branch': 'Firefox-Non-PGO', 15:12:16 INFO - 'buildbot_json_path': 'buildprops.json', 15:12:16 INFO - 'config_files': ('talos/linux_config.py',), 15:12:16 INFO - 'default_actions': ('clobber', 15:12:16 INFO - 'read-buildbot-config', 15:12:16 INFO - 'download-and-extract', 15:12:16 INFO - 'populate-webroot', 15:12:16 INFO - 'create-virtualenv', 15:12:16 INFO - 'install', 15:12:16 INFO - 'run-tests'), 15:12:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:12:16 INFO - 'download_minidump_stackwalk': True, 15:12:16 INFO - 'download_symbols': 'ondemand', 15:12:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:12:16 INFO - 'tooltool.py': '/tools/tooltool.py', 15:12:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:12:16 INFO - '/tools/misc-python/virtualenv.py')}, 15:12:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:12:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:12:16 INFO - 'installer_path': 'installer.exe', 15:12:16 INFO - 'log_level': 'info', 15:12:16 INFO - 'log_name': 'talos', 15:12:16 INFO - 'log_to_console': True, 15:12:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:12:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:12:16 INFO - 'opt_config_files': (), 15:12:16 INFO - 'pip_index': False, 15:12:16 INFO - 'sps_profile': False, 15:12:16 INFO - 'sps_profile_interval': 0, 15:12:16 INFO - 'suite': 'dromaeojs', 15:12:16 INFO - 'system_bits': '32', 15:12:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:12:16 INFO - 'title': 'talos-linux64-ix-020', 15:12:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:12:16 INFO - 'use_talos_json': True, 15:12:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:12:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:12:16 INFO - 'work_dir': 'build'} 15:12:16 INFO - [mozharness: 2016-08-23 22:12:16.210079Z] Running clobber step. 15:12:16 INFO - Running pre-action listener: _resource_record_pre_action 15:12:16 INFO - Running main action method: clobber 15:12:16 INFO - rmtree: /builds/slave/test/build 15:12:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:12:17 INFO - Running post-action listener: _resource_record_post_action 15:12:17 INFO - [mozharness: 2016-08-23 22:12:17.187697Z] Finished clobber step (success) 15:12:17 INFO - [mozharness: 2016-08-23 22:12:17.187799Z] Running read-buildbot-config step. 15:12:17 INFO - Running pre-action listener: _resource_record_pre_action 15:12:17 INFO - Running main action method: read_buildbot_config 15:12:17 INFO - Using buildbot properties: 15:12:17 INFO - { 15:12:17 INFO - "project": "", 15:12:17 INFO - "product": "firefox", 15:12:17 INFO - "script_repo_revision": "production", 15:12:17 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 15:12:17 INFO - "repository": "", 15:12:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 15:12:17 INFO - "buildid": "20160823135114", 15:12:17 INFO - "pgo_build": "False", 15:12:17 INFO - "basedir": "/builds/slave/test", 15:12:17 INFO - "buildnumber": 185, 15:12:17 INFO - "slavename": "talos-linux64-ix-020", 15:12:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:12:17 INFO - "platform": "ubuntu64_hw", 15:12:17 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 15:12:17 INFO - "branch": "mozilla-central", 15:12:17 INFO - "repo_path": "mozilla-central", 15:12:17 INFO - "revision": "ca24710db69ad1b51f415889a6276a53bc59d36c", 15:12:17 INFO - "stage_platform": "linux64", 15:12:17 INFO - "builduid": "bc0d5fcf32bb4eec82bf76526eb0965d", 15:12:17 INFO - "slavebuilddir": "test" 15:12:17 INFO - } 15:12:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/Darib8q4Q76VZa-jXt8x9w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 15:12:17 INFO - Running post-action listener: _resource_record_post_action 15:12:17 INFO - [mozharness: 2016-08-23 22:12:17.190245Z] Finished read-buildbot-config step (success) 15:12:17 INFO - [mozharness: 2016-08-23 22:12:17.190334Z] Running download-and-extract step. 15:12:17 INFO - Running pre-action listener: _resource_record_pre_action 15:12:17 INFO - Running main action method: download_and_extract 15:12:17 INFO - mkdir: /builds/slave/test/build/tests 15:12:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:12:17 INFO - trying https://queue.taskcluster.net/v1/task/Darib8q4Q76VZa-jXt8x9w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 15:12:17 INFO - Downloading https://queue.taskcluster.net/v1/task/Darib8q4Q76VZa-jXt8x9w/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 15:12:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Darib8q4Q76VZa-jXt8x9w/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 15:12:17 INFO - Downloaded 1361 bytes. 15:12:17 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 15:12:17 INFO - Using the following test package requirements: 15:12:17 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 15:12:17 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:12:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:12:17 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:12:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:12:17 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:12:17 INFO - u'jsshell-linux-x86_64.zip'], 15:12:17 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:12:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:12:17 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 15:12:17 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:12:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:12:17 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:12:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:12:17 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:12:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:12:17 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:12:17 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:12:17 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:12:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:12:17 INFO - trying https://queue.taskcluster.net/v1/task/Darib8q4Q76VZa-jXt8x9w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:12:17 INFO - Downloading https://queue.taskcluster.net/v1/task/Darib8q4Q76VZa-jXt8x9w/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 15:12:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Darib8q4Q76VZa-jXt8x9w/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 15:12:18 INFO - Downloaded 20324416 bytes. 15:12:18 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 15:12:22 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 15:12:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:12:22 INFO - trying https://queue.taskcluster.net/v1/task/Darib8q4Q76VZa-jXt8x9w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:12:22 INFO - Downloading https://queue.taskcluster.net/v1/task/Darib8q4Q76VZa-jXt8x9w/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 15:12:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Darib8q4Q76VZa-jXt8x9w/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 15:12:23 INFO - Downloaded 20324416 bytes. 15:12:23 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 15:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:12:28 INFO - trying https://queue.taskcluster.net/v1/task/Darib8q4Q76VZa-jXt8x9w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 15:12:28 INFO - Downloading https://queue.taskcluster.net/v1/task/Darib8q4Q76VZa-jXt8x9w/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 15:12:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Darib8q4Q76VZa-jXt8x9w/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 15:12:29 INFO - Downloaded 14413981 bytes. 15:12:29 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 15:12:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:12:29 INFO - trying https://queue.taskcluster.net/v1/task/Darib8q4Q76VZa-jXt8x9w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:12:29 INFO - Downloading https://queue.taskcluster.net/v1/task/Darib8q4Q76VZa-jXt8x9w/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 15:12:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Darib8q4Q76VZa-jXt8x9w/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 15:12:30 INFO - Downloaded 55738782 bytes. 15:12:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Darib8q4Q76VZa-jXt8x9w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:12:30 INFO - mkdir: /builds/slave/test/properties 15:12:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:12:30 INFO - Writing to file /builds/slave/test/properties/build_url 15:12:30 INFO - Contents: 15:12:30 INFO - build_url:https://queue.taskcluster.net/v1/task/Darib8q4Q76VZa-jXt8x9w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:12:31 INFO - Running post-action listener: _resource_record_post_action 15:12:31 INFO - Running post-action listener: set_extra_try_arguments 15:12:31 INFO - [mozharness: 2016-08-23 22:12:31.375513Z] Finished download-and-extract step (success) 15:12:31 INFO - [mozharness: 2016-08-23 22:12:31.375740Z] Running populate-webroot step. 15:12:31 INFO - Running pre-action listener: _resource_record_pre_action 15:12:31 INFO - Running main action method: populate_webroot 15:12:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:12:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:12:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:12:31 INFO - '--tppagecycles', 15:12:31 INFO - '7'], 15:12:31 INFO - 'tests': ['tsvgm']}}, 15:12:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:12:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:12:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:12:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:12:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:12:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:12:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:12:31 INFO - 'talos_options': ['--disable-e10s'], 15:12:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:12:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:12:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:12:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:12:31 INFO - 'talos_options': ['--disable-e10s'], 15:12:31 INFO - 'tests': ['damp', 'tps']}, 15:12:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:12:31 INFO - 'tests': ['damp', 'tps']}, 15:12:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:12:31 INFO - 'tests': ['dromaeo_dom']}, 15:12:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:12:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:12:31 INFO - 'tests': ['basic_compositor_video']}, 15:12:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:12:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:12:31 INFO - 'tests': ['a11yr', 15:12:31 INFO - 'ts_paint', 15:12:31 INFO - 'tpaint', 15:12:31 INFO - 'sessionrestore', 15:12:31 INFO - 'sessionrestore_no_auto_restore', 15:12:31 INFO - 'tabpaint']}, 15:12:31 INFO - 'other-e10s': {'tests': ['a11yr', 15:12:31 INFO - 'ts_paint', 15:12:31 INFO - 'tpaint', 15:12:31 INFO - 'sessionrestore', 15:12:31 INFO - 'sessionrestore_no_auto_restore', 15:12:31 INFO - 'tabpaint']}, 15:12:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:12:31 INFO - 'ts_paint', 15:12:31 INFO - 'tpaint', 15:12:31 INFO - 'sessionrestore', 15:12:31 INFO - 'sessionrestore_no_auto_restore', 15:12:31 INFO - 'tabpaint']}, 15:12:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:12:31 INFO - 'ts_paint', 15:12:31 INFO - 'tpaint', 15:12:31 INFO - 'sessionrestore', 15:12:31 INFO - 'sessionrestore_no_auto_restore', 15:12:31 INFO - 'tabpaint']}, 15:12:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:12:31 INFO - 'tests': ['a11yr', 15:12:31 INFO - 'ts_paint', 15:12:31 INFO - 'tpaint', 15:12:31 INFO - 'sessionrestore', 15:12:31 INFO - 'sessionrestore_no_auto_restore', 15:12:31 INFO - 'tabpaint']}, 15:12:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:12:31 INFO - 'tests': ['a11yr', 15:12:31 INFO - 'ts_paint', 15:12:31 INFO - 'tpaint', 15:12:31 INFO - 'sessionrestore', 15:12:31 INFO - 'sessionrestore_no_auto_restore', 15:12:31 INFO - 'tabpaint']}, 15:12:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:12:31 INFO - 'tests': ['tsvgx', 15:12:31 INFO - 'tsvgr_opacity', 15:12:31 INFO - 'tart', 15:12:31 INFO - 'tscrollx', 15:12:31 INFO - 'cart']}, 15:12:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:12:31 INFO - 'tsvgr_opacity', 15:12:31 INFO - 'tart', 15:12:31 INFO - 'tscrollx', 15:12:31 INFO - 'cart']}, 15:12:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:12:31 INFO - 'talos_options': ['--disable-e10s'], 15:12:31 INFO - 'tests': ['tp5o']}, 15:12:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:12:31 INFO - 'tests': ['tp5o']}, 15:12:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:12:31 INFO - 'talos_options': ['--disable-e10s', 15:12:31 INFO - '--xperf_path', 15:12:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:12:31 INFO - 'tests': ['tp5n']}, 15:12:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:12:31 INFO - 'talos_options': ['--xperf_path', 15:12:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:12:31 INFO - 'tests': ['tp5n']}}, 15:12:31 INFO - 'talos.zip': {'path': '', 15:12:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:12:31 INFO - Running post-action listener: _resource_record_post_action 15:12:31 INFO - [mozharness: 2016-08-23 22:12:31.397399Z] Finished populate-webroot step (success) 15:12:31 INFO - [mozharness: 2016-08-23 22:12:31.397488Z] Running create-virtualenv step. 15:12:31 INFO - Running pre-action listener: _resource_record_pre_action 15:12:31 INFO - Running main action method: create_virtualenv 15:12:31 INFO - Creating virtualenv /builds/slave/test/build/venv 15:12:31 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:12:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:12:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:12:31 INFO - Using real prefix '/usr' 15:12:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:12:32 INFO - Installing distribute.............................................................................................................................................................................................done. 15:12:33 INFO - Installing pip.................done. 15:12:33 INFO - Return code: 0 15:12:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:12:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:33 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 0x7fa327531f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c0230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ba090>, '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 0x29bd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bde40>, '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': 'af724c981e2a0f424dbabf99000001e7-1471990334.421674-1947986402', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:12:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:12:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:12:33 INFO - Using env: {'DISPLAY': ':0', 15:12:33 INFO - 'HOME': '/home/cltbld', 15:12:33 INFO - 'LANG': 'en_US.UTF-8', 15:12:33 INFO - 'LANGUAGE': 'en_US:en', 15:12:33 INFO - 'LOGNAME': 'cltbld', 15:12:33 INFO - 'MAIL': '/var/mail/cltbld', 15:12:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:33 INFO - 'MOZ_NO_REMOTE': '1', 15:12:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:33 INFO - 'NO_EM_RESTART': '1', 15:12:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:33 INFO - 'PWD': '/builds/slave/test', 15:12:33 INFO - 'SHELL': '/bin/bash', 15:12:33 INFO - 'SHLVL': '1', 15:12:33 INFO - 'TERM': 'linux', 15:12:33 INFO - 'TMOUT': '86400', 15:12:33 INFO - 'USER': 'cltbld', 15:12:33 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1471990334.421674-1947986402', 15:12:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:33 INFO - '_': '/tools/buildbot/bin/python'} 15:12:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:12:34 INFO - Cleaning up... 15:12:34 INFO - Return code: 0 15:12:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:12: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')]} 15:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12: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')]} 15:12:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:34 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 0x7fa327531f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c0230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ba090>, '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 0x29bd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bde40>, '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': 'af724c981e2a0f424dbabf99000001e7-1471990334.421674-1947986402', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:12:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:12:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:12:34 INFO - Using env: {'DISPLAY': ':0', 15:12:34 INFO - 'HOME': '/home/cltbld', 15:12:34 INFO - 'LANG': 'en_US.UTF-8', 15:12:34 INFO - 'LANGUAGE': 'en_US:en', 15:12:34 INFO - 'LOGNAME': 'cltbld', 15:12:34 INFO - 'MAIL': '/var/mail/cltbld', 15:12:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:34 INFO - 'MOZ_NO_REMOTE': '1', 15:12:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:34 INFO - 'NO_EM_RESTART': '1', 15:12:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:34 INFO - 'PWD': '/builds/slave/test', 15:12:34 INFO - 'SHELL': '/bin/bash', 15:12:34 INFO - 'SHLVL': '1', 15:12:34 INFO - 'TERM': 'linux', 15:12:34 INFO - 'TMOUT': '86400', 15:12:34 INFO - 'USER': 'cltbld', 15:12:34 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1471990334.421674-1947986402', 15:12:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:34 INFO - '_': '/tools/buildbot/bin/python'} 15:12:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:34 INFO - Downloading/unpacking psutil>=3.1.1 15:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:12:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:12:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:12:36 INFO - Installing collected packages: psutil 15:12:36 INFO - Running setup.py install for psutil 15:12:36 INFO - building 'psutil._psutil_linux' extension 15:12:36 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:12:36 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:12:36 INFO - building 'psutil._psutil_posix' extension 15:12:36 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:12:36 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:12:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:12:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:12:36 INFO - Successfully installed psutil 15:12:36 INFO - Cleaning up... 15:12:36 INFO - Return code: 0 15:12:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:12: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')]} 15:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12: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')]} 15:12:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:36 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 0x7fa327531f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c0230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ba090>, '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 0x29bd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bde40>, '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': 'af724c981e2a0f424dbabf99000001e7-1471990334.421674-1947986402', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:12:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:12:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:12:36 INFO - Using env: {'DISPLAY': ':0', 15:12:36 INFO - 'HOME': '/home/cltbld', 15:12:36 INFO - 'LANG': 'en_US.UTF-8', 15:12:36 INFO - 'LANGUAGE': 'en_US:en', 15:12:36 INFO - 'LOGNAME': 'cltbld', 15:12:36 INFO - 'MAIL': '/var/mail/cltbld', 15:12:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:36 INFO - 'MOZ_NO_REMOTE': '1', 15:12:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:36 INFO - 'NO_EM_RESTART': '1', 15:12:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:36 INFO - 'PWD': '/builds/slave/test', 15:12:36 INFO - 'SHELL': '/bin/bash', 15:12:36 INFO - 'SHLVL': '1', 15:12:36 INFO - 'TERM': 'linux', 15:12:36 INFO - 'TMOUT': '86400', 15:12:36 INFO - 'USER': 'cltbld', 15:12:36 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1471990334.421674-1947986402', 15:12:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:36 INFO - '_': '/tools/buildbot/bin/python'} 15:12:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:12:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:12:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:12:39 INFO - Installing collected packages: mozsystemmonitor 15:12:39 INFO - Running setup.py install for mozsystemmonitor 15:12:39 INFO - Successfully installed mozsystemmonitor 15:12:39 INFO - Cleaning up... 15:12:39 INFO - Return code: 0 15:12:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:12:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:12:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:39 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 0x7fa327531f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c0230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ba090>, '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 0x29bd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bde40>, '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': 'af724c981e2a0f424dbabf99000001e7-1471990334.421674-1947986402', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:12:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:12:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:12:39 INFO - Using env: {'DISPLAY': ':0', 15:12:39 INFO - 'HOME': '/home/cltbld', 15:12:39 INFO - 'LANG': 'en_US.UTF-8', 15:12:39 INFO - 'LANGUAGE': 'en_US:en', 15:12:39 INFO - 'LOGNAME': 'cltbld', 15:12:39 INFO - 'MAIL': '/var/mail/cltbld', 15:12:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:39 INFO - 'MOZ_NO_REMOTE': '1', 15:12:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:39 INFO - 'NO_EM_RESTART': '1', 15:12:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:39 INFO - 'PWD': '/builds/slave/test', 15:12:39 INFO - 'SHELL': '/bin/bash', 15:12:39 INFO - 'SHLVL': '1', 15:12:39 INFO - 'TERM': 'linux', 15:12:39 INFO - 'TMOUT': '86400', 15:12:39 INFO - 'USER': 'cltbld', 15:12:39 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1471990334.421674-1947986402', 15:12:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:39 INFO - '_': '/tools/buildbot/bin/python'} 15:12:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:39 INFO - Downloading/unpacking jsonschema==2.5.1 15:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:12:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:12: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 15:12: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 15:12: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 15:12: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 15:12: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 15:12: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 15:12:41 INFO - Downloading functools32-3.2.3-2.tar.gz 15:12:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:12:41 INFO - warning: no files found matching '*.txt' 15:12:41 INFO - no previously-included directories found matching 'build' 15:12:41 INFO - no previously-included directories found matching 'dist' 15:12:41 INFO - no previously-included directories found matching '.git*' 15:12:41 INFO - Installing collected packages: jsonschema, functools32 15:12:41 INFO - Running setup.py install for functools32 15:12:41 INFO - warning: no files found matching '*.txt' 15:12:41 INFO - no previously-included directories found matching 'build' 15:12:41 INFO - no previously-included directories found matching 'dist' 15:12:41 INFO - no previously-included directories found matching '.git*' 15:12:41 INFO - Successfully installed jsonschema functools32 15:12:41 INFO - Cleaning up... 15:12:41 INFO - Return code: 0 15:12:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:12:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:12:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12: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', '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 0x7fa327531f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c0230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ba090>, '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 0x29bd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bde40>, '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': 'af724c981e2a0f424dbabf99000001e7-1471990334.421674-1947986402', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:12: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:12: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 functools32==3.2.3-2 15:12:41 INFO - Using env: {'DISPLAY': ':0', 15:12:41 INFO - 'HOME': '/home/cltbld', 15:12:41 INFO - 'LANG': 'en_US.UTF-8', 15:12:41 INFO - 'LANGUAGE': 'en_US:en', 15:12:41 INFO - 'LOGNAME': 'cltbld', 15:12:41 INFO - 'MAIL': '/var/mail/cltbld', 15:12:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:41 INFO - 'MOZ_NO_REMOTE': '1', 15:12:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:41 INFO - 'NO_EM_RESTART': '1', 15:12:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:41 INFO - 'PWD': '/builds/slave/test', 15:12:41 INFO - 'SHELL': '/bin/bash', 15:12:41 INFO - 'SHLVL': '1', 15:12:41 INFO - 'TERM': 'linux', 15:12:41 INFO - 'TMOUT': '86400', 15:12:41 INFO - 'USER': 'cltbld', 15:12:41 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1471990334.421674-1947986402', 15:12:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:41 INFO - '_': '/tools/buildbot/bin/python'} 15:12:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:12:42 INFO - Cleaning up... 15:12:42 INFO - Return code: 0 15:12:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:12:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:12:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:42 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 0x7fa327531f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c0230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ba090>, '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 0x29bd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bde40>, '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': 'af724c981e2a0f424dbabf99000001e7-1471990334.421674-1947986402', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:12:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:12:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:12:42 INFO - Using env: {'DISPLAY': ':0', 15:12:42 INFO - 'HOME': '/home/cltbld', 15:12:42 INFO - 'LANG': 'en_US.UTF-8', 15:12:42 INFO - 'LANGUAGE': 'en_US:en', 15:12:42 INFO - 'LOGNAME': 'cltbld', 15:12:42 INFO - 'MAIL': '/var/mail/cltbld', 15:12:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:42 INFO - 'MOZ_NO_REMOTE': '1', 15:12:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:42 INFO - 'NO_EM_RESTART': '1', 15:12:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:42 INFO - 'PWD': '/builds/slave/test', 15:12:42 INFO - 'SHELL': '/bin/bash', 15:12:42 INFO - 'SHLVL': '1', 15:12:42 INFO - 'TERM': 'linux', 15:12:42 INFO - 'TMOUT': '86400', 15:12:42 INFO - 'USER': 'cltbld', 15:12:42 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1471990334.421674-1947986402', 15:12:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:42 INFO - '_': '/tools/buildbot/bin/python'} 15:12:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:42 INFO - Downloading/unpacking blobuploader==1.2.4 15:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:44 INFO - Downloading blobuploader-1.2.4.tar.gz 15:12:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:12:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:12: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 15:12: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 15:12: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 15:12: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 15:12: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 15:12: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 15:12:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:12:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:12: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 15:12: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 15:12: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 15:12: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 15:12: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 15:12: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 15:12:44 INFO - Downloading docopt-0.6.1.tar.gz 15:12:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:12:44 INFO - Installing collected packages: blobuploader, requests, docopt 15:12:44 INFO - Running setup.py install for blobuploader 15:12:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:12:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:12:45 INFO - Running setup.py install for requests 15:12:45 INFO - Running setup.py install for docopt 15:12:45 INFO - Successfully installed blobuploader requests docopt 15:12:45 INFO - Cleaning up... 15:12:45 INFO - Return code: 0 15:12:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:12:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:12:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:45 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 0x7fa327531f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c0230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ba090>, '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 0x29bd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bde40>, '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': 'af724c981e2a0f424dbabf99000001e7-1471990334.421674-1947986402', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:12:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:12:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:12:45 INFO - Using env: {'DISPLAY': ':0', 15:12:45 INFO - 'HOME': '/home/cltbld', 15:12:45 INFO - 'LANG': 'en_US.UTF-8', 15:12:45 INFO - 'LANGUAGE': 'en_US:en', 15:12:45 INFO - 'LOGNAME': 'cltbld', 15:12:45 INFO - 'MAIL': '/var/mail/cltbld', 15:12:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:45 INFO - 'MOZ_NO_REMOTE': '1', 15:12:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:45 INFO - 'NO_EM_RESTART': '1', 15:12:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:45 INFO - 'PWD': '/builds/slave/test', 15:12:45 INFO - 'SHELL': '/bin/bash', 15:12:45 INFO - 'SHLVL': '1', 15:12:45 INFO - 'TERM': 'linux', 15:12:45 INFO - 'TMOUT': '86400', 15:12:45 INFO - 'USER': 'cltbld', 15:12:45 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1471990334.421674-1947986402', 15:12:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:45 INFO - '_': '/tools/buildbot/bin/python'} 15:12:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:12:45 INFO - Running setup.py (path:/tmp/pip-2JpuHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:12:45 INFO - Running setup.py (path:/tmp/pip-Webf3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:12:45 INFO - Running setup.py (path:/tmp/pip-mD5VOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:12:45 INFO - Running setup.py (path:/tmp/pip-qXuvRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:12:46 INFO - Running setup.py (path:/tmp/pip-dzPuX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:12:46 INFO - Running setup.py (path:/tmp/pip-IFsH8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:12:46 INFO - Running setup.py (path:/tmp/pip-YgVMgo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:12:46 INFO - Running setup.py (path:/tmp/pip-LFFYL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:12:46 INFO - Running setup.py (path:/tmp/pip-Z25gpV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:12:46 INFO - Running setup.py (path:/tmp/pip-yXkRMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:12:46 INFO - Running setup.py (path:/tmp/pip-vJ53yO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:12:46 INFO - Running setup.py (path:/tmp/pip-JVMg0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:12:46 INFO - Running setup.py (path:/tmp/pip-STC8pH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:12:46 INFO - Running setup.py (path:/tmp/pip-vCiNpO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:12:46 INFO - Running setup.py (path:/tmp/pip-5tfQLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:12:46 INFO - Running setup.py (path:/tmp/pip-he1nft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:12:46 INFO - Running setup.py (path:/tmp/pip-L7OXXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:12:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:12:46 INFO - Running setup.py install for manifestparser 15:12:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:12:47 INFO - Running setup.py install for mozcrash 15:12:47 INFO - Running setup.py install for mozdebug 15:12:47 INFO - Running setup.py install for mozdevice 15:12:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:12:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:12:47 INFO - Running setup.py install for mozfile 15:12:47 INFO - Running setup.py install for mozhttpd 15:12:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:12:47 INFO - Running setup.py install for mozinfo 15:12:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:12:47 INFO - Running setup.py install for mozInstall 15:12:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:12:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:12:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:12:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:12:47 INFO - Running setup.py install for mozleak 15:12:47 INFO - Running setup.py install for mozlog 15:12:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:12:48 INFO - Running setup.py install for moznetwork 15:12:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:12:48 INFO - Running setup.py install for mozprocess 15:12:48 INFO - Running setup.py install for mozprofile 15:12:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:12:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:12:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:12:48 INFO - Running setup.py install for mozrunner 15:12:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:12:48 INFO - Running setup.py install for mozscreenshot 15:12:48 INFO - Running setup.py install for moztest 15:12:48 INFO - Running setup.py install for mozversion 15:12:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:12:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:12:48 INFO - Cleaning up... 15:12:48 INFO - Return code: 0 15:12:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:12:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:12:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:48 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 0x7fa327531f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c0230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ba090>, '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 0x29bd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bde40>, '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': 'af724c981e2a0f424dbabf99000001e7-1471990334.421674-1947986402', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:12:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:12:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:12:48 INFO - Using env: {'DISPLAY': ':0', 15:12:48 INFO - 'HOME': '/home/cltbld', 15:12:48 INFO - 'LANG': 'en_US.UTF-8', 15:12:48 INFO - 'LANGUAGE': 'en_US:en', 15:12:48 INFO - 'LOGNAME': 'cltbld', 15:12:48 INFO - 'MAIL': '/var/mail/cltbld', 15:12:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:48 INFO - 'MOZ_NO_REMOTE': '1', 15:12:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:48 INFO - 'NO_EM_RESTART': '1', 15:12:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:48 INFO - 'PWD': '/builds/slave/test', 15:12:48 INFO - 'SHELL': '/bin/bash', 15:12:48 INFO - 'SHLVL': '1', 15:12:48 INFO - 'TERM': 'linux', 15:12:48 INFO - 'TMOUT': '86400', 15:12:48 INFO - 'USER': 'cltbld', 15:12:48 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1471990334.421674-1947986402', 15:12:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:48 INFO - '_': '/tools/buildbot/bin/python'} 15:12:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:12:49 INFO - Running setup.py (path:/tmp/pip-e_7h3X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:12:49 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:12:49 INFO - Running setup.py (path:/tmp/pip-JsrjvA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:12:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:12:49 INFO - Running setup.py (path:/tmp/pip-ZTS6ne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:12:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:12:49 INFO - Running setup.py (path:/tmp/pip-FbgpNq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:12:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:12:49 INFO - Running setup.py (path:/tmp/pip-hGOf72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:12:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:12:49 INFO - Running setup.py (path:/tmp/pip-7CvPrN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:12:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:12:49 INFO - Running setup.py (path:/tmp/pip-ZzchFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:12:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:12:49 INFO - Running setup.py (path:/tmp/pip-ZGaIjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:12:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:12:49 INFO - Running setup.py (path:/tmp/pip-GYgqtF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:12:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:12:49 INFO - Running setup.py (path:/tmp/pip-79bQUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:12:49 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)) 15:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:12:49 INFO - Running setup.py (path:/tmp/pip-Va99U5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:12:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:12:49 INFO - Running setup.py (path:/tmp/pip-SOUnQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:12:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:12:49 INFO - Running setup.py (path:/tmp/pip-7wfngd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:12:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:12:49 INFO - Running setup.py (path:/tmp/pip-FObhXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:12:50 INFO - Running setup.py (path:/tmp/pip-fbX8Ej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:12:50 INFO - Running setup.py (path:/tmp/pip-2ZMtRL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:12:50 INFO - Running setup.py (path:/tmp/pip-rceSDp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:12:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:52 INFO - Downloading blessings-1.6.tar.gz 15:12:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:12:52 INFO - Installing collected packages: blessings 15:12:52 INFO - Running setup.py install for blessings 15:12:52 INFO - Successfully installed blessings 15:12:52 INFO - Cleaning up... 15:12:52 INFO - Return code: 0 15:12:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:12:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:12:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:12:52 INFO - Reading from file tmpfile_stdout 15:12:52 INFO - Current package versions: 15:12:52 INFO - argparse == 1.2.1 15:12:52 INFO - blessings == 1.6 15:12:52 INFO - blobuploader == 1.2.4 15:12:52 INFO - docopt == 0.6.1 15:12:52 INFO - functools32 == 3.2.3-2 15:12:52 INFO - jsonschema == 2.5.1 15:12:52 INFO - manifestparser == 1.1 15:12:52 INFO - mozInstall == 1.12 15:12:52 INFO - mozcrash == 0.17 15:12:52 INFO - mozdebug == 0.1 15:12:52 INFO - mozdevice == 0.48 15:12:52 INFO - mozfile == 1.2 15:12:52 INFO - mozhttpd == 0.7 15:12:52 INFO - mozinfo == 0.9 15:12:52 INFO - mozleak == 0.1 15:12:52 INFO - mozlog == 3.3 15:12:52 INFO - moznetwork == 0.27 15:12:52 INFO - mozprocess == 0.23 15:12:52 INFO - mozprofile == 0.28 15:12:52 INFO - mozrunner == 6.12 15:12:52 INFO - mozscreenshot == 0.1 15:12:52 INFO - mozsystemmonitor == 0.3 15:12:52 INFO - moztest == 0.7 15:12:52 INFO - mozversion == 1.4 15:12:52 INFO - psutil == 3.1.1 15:12:52 INFO - requests == 1.2.3 15:12:52 INFO - wsgiref == 0.1.2 15:12:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:12: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')]} 15:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12: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')]} 15:12:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:52 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 0x7fa327531f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c0230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ba090>, '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 0x29bd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bde40>, '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': 'af724c981e2a0f424dbabf99000001e7-1471990334.421674-1947986402', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:12:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:12:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:12:52 INFO - Using env: {'DISPLAY': ':0', 15:12:52 INFO - 'HOME': '/home/cltbld', 15:12:52 INFO - 'LANG': 'en_US.UTF-8', 15:12:52 INFO - 'LANGUAGE': 'en_US:en', 15:12:52 INFO - 'LOGNAME': 'cltbld', 15:12:52 INFO - 'MAIL': '/var/mail/cltbld', 15:12:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:52 INFO - 'MOZ_NO_REMOTE': '1', 15:12:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:52 INFO - 'NO_EM_RESTART': '1', 15:12:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:52 INFO - 'PWD': '/builds/slave/test', 15:12:52 INFO - 'SHELL': '/bin/bash', 15:12:52 INFO - 'SHLVL': '1', 15:12:52 INFO - 'TERM': 'linux', 15:12:52 INFO - 'TMOUT': '86400', 15:12:52 INFO - 'USER': 'cltbld', 15:12:52 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1471990334.421674-1947986402', 15:12:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:52 INFO - '_': '/tools/buildbot/bin/python'} 15:12:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:12:52 INFO - Cleaning up... 15:12:52 INFO - Return code: 0 15:12:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:12: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')]} 15:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12: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')]} 15:12:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:52 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 0x7fa327531f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c0230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ba090>, '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 0x29bd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bde40>, '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': 'af724c981e2a0f424dbabf99000001e7-1471990334.421674-1947986402', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:12:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:12:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:12:52 INFO - Using env: {'DISPLAY': ':0', 15:12:52 INFO - 'HOME': '/home/cltbld', 15:12:52 INFO - 'LANG': 'en_US.UTF-8', 15:12:52 INFO - 'LANGUAGE': 'en_US:en', 15:12:52 INFO - 'LOGNAME': 'cltbld', 15:12:52 INFO - 'MAIL': '/var/mail/cltbld', 15:12:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:52 INFO - 'MOZ_NO_REMOTE': '1', 15:12:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:52 INFO - 'NO_EM_RESTART': '1', 15:12:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:52 INFO - 'PWD': '/builds/slave/test', 15:12:52 INFO - 'SHELL': '/bin/bash', 15:12:52 INFO - 'SHLVL': '1', 15:12:52 INFO - 'TERM': 'linux', 15:12:52 INFO - 'TMOUT': '86400', 15:12:52 INFO - 'USER': 'cltbld', 15:12:52 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1471990334.421674-1947986402', 15:12:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:52 INFO - '_': '/tools/buildbot/bin/python'} 15:12:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:12:53 INFO - Cleaning up... 15:12:53 INFO - Return code: 0 15:12:53 INFO - Running post-action listener: _resource_record_post_action 15:12:53 INFO - Running post-action listener: _start_resource_monitoring 15:12:53 INFO - Starting resource monitoring. 15:12:53 INFO - [mozharness: 2016-08-23 22:12:53.063207Z] Finished create-virtualenv step (success) 15:12:53 INFO - [mozharness: 2016-08-23 22:12:53.063676Z] Running install step. 15:12:53 INFO - Running pre-action listener: _resource_record_pre_action 15:12:53 INFO - Running main action method: install 15:12:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:12:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:12:53 INFO - Reading from file tmpfile_stdout 15:12:53 INFO - Detecting whether we're running mozinstall >=1.0... 15:12:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:12:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:12:53 INFO - Reading from file tmpfile_stdout 15:12:53 INFO - Output received: 15:12:53 INFO - Usage: mozinstall [options] installer 15:12:53 INFO - Options: 15:12:53 INFO - -h, --help show this help message and exit 15:12:53 INFO - -d DEST, --destination=DEST 15:12:53 INFO - Directory to install application into. [default: 15:12:53 INFO - "/builds/slave/test"] 15:12:53 INFO - --app=APP Application being installed. [default: firefox] 15:12:53 INFO - mkdir: /builds/slave/test/build/application 15:12:53 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'] 15:12:53 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 15:13:09 INFO - Reading from file tmpfile_stdout 15:13:09 INFO - Output received: 15:13:09 INFO - /builds/slave/test/build/application/firefox/firefox 15:13:09 INFO - Running post-action listener: _resource_record_post_action 15:13:09 INFO - [mozharness: 2016-08-23 22:13:09.455171Z] Finished install step (success) 15:13:09 INFO - [mozharness: 2016-08-23 22:13:09.455418Z] Running run-tests step. 15:13:09 INFO - Running pre-action listener: _resource_record_pre_action 15:13:09 INFO - Running main action method: run_tests 15:13:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:13:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:13:09 INFO - Python 2.7.3 15:13:09 INFO - Return code: 0 15:13:09 INFO - grabbing minidump binary from tooltool 15:13:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:13:09 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 0x29ba090>, '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 0x29bd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29bde40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:13:09 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:13:09 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:13:09 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:13:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:13:09 INFO - Return code: 0 15:13:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:13:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:13:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:13:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:13:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:13:09 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/Darib8q4Q76VZa-jXt8x9w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 15:13:09 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/Darib8q4Q76VZa-jXt8x9w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 15:13:09 INFO - Using env: {'DISPLAY': ':0', 15:13:09 INFO - 'HOME': '/home/cltbld', 15:13:09 INFO - 'LANG': 'en_US.UTF-8', 15:13:09 INFO - 'LANGUAGE': 'en_US:en', 15:13:09 INFO - 'LOGNAME': 'cltbld', 15:13:09 INFO - 'MAIL': '/var/mail/cltbld', 15:13:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:13:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:13:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:09 INFO - 'MOZ_NO_REMOTE': '1', 15:13:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:13:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:09 INFO - 'NO_EM_RESTART': '1', 15:13:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:09 INFO - 'PWD': '/builds/slave/test', 15:13:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:13:09 INFO - 'SHELL': '/bin/bash', 15:13:09 INFO - 'SHLVL': '1', 15:13:09 INFO - 'TERM': 'linux', 15:13:09 INFO - 'TMOUT': '86400', 15:13:09 INFO - 'USER': 'cltbld', 15:13:09 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1471990334.421674-1947986402', 15:13:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:09 INFO - '_': '/tools/buildbot/bin/python'} 15:13:09 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/Darib8q4Q76VZa-jXt8x9w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 15:13:09 INFO - mozversion application_buildid: 20160823135114 15:13:09 INFO - mozversion application_changeset: ca24710db69ad1b51f415889a6276a53bc59d36c 15:13:09 INFO - mozversion application_display_name: Nightly 15:13:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:13:09 INFO - mozversion application_name: Firefox 15:13:09 INFO - mozversion application_remotingname: firefox 15:13:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:13:09 INFO - mozversion application_vendor: Mozilla 15:13:09 INFO - mozversion application_version: 51.0a1 15:13:09 INFO - mozversion platform_buildid: 20160823135114 15:13:09 INFO - mozversion platform_changeset: ca24710db69ad1b51f415889a6276a53bc59d36c 15:13:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:13:09 INFO - mozversion platform_version: 51.0a1 15:13:09 INFO - using testdate: 1471990389 15:13:09 INFO - actual date: 1471990389 15:13:09 INFO - starting webserver on 'localhost:33651' 15:13:09 INFO - SUITE-START | Running 2 tests 15:13:09 INFO - TEST-START | dromaeo_css 15:13:09 INFO - operating with platform_type : linux_ 15:13:09 INFO - Initialising browser for dromaeo_css test... 15:13:09 INFO - TEST-INFO | started process 26091 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1sk_rd/profile http://localhost:33651/getInfo.html) 15:13:14 INFO - PROCESS | 26091 | __metrics Screen width/height:1600/1200 15:13:14 INFO - PROCESS | 26091 | colorDepth:24 15:13:14 INFO - PROCESS | 26091 | Browser inner width/height: 1024/697 15:13:14 INFO - PROCESS | 26091 | __metrics 15:13:15 INFO - PROCESS | 26091 | 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" 15:13:15 INFO - PROCESS | 26091 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:13:15 INFO - PROCESS | 26091 | console.error: PushService: 15:13:15 INFO - PROCESS | 26091 | stateChangeProcessEnqueue: Error transitioning state 15:13:15 INFO - PROCESS | 26091 | UnknownError 15:13:16 INFO - TEST-INFO | 26091: exit 0 15:13:16 INFO - Browser initialized. 15:13:16 INFO - Running cycle 1/1 for dromaeo_css test... 15:13:16 INFO - TEST-INFO | started process 26169 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1sk_rd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:13:28 INFO - PROCESS | 26169 | RSS: Main: 182956032 15:13:28 INFO - PROCESS | 26169 | 15:14:20 INFO - PROCESS | 26169 | 1471990460005 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:16:33 INFO - PROCESS | 26169 | Cycle 1(1): loaded http://localhost:33651/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33651/tests/dromaeo/cssquery-ext.html) 15:16:34 INFO - PROCESS | 26169 | RSS: Main: 264474624 15:16:34 INFO - PROCESS | 26169 | 15:19:37 INFO - PROCESS | 26169 | Cycle 1(1): loaded http://localhost:33651/tests/dromaeo/cssquery-ext.html (next: http://localhost:33651/tests/dromaeo/cssquery-jquery.html) 15:19:37 INFO - PROCESS | 26169 | RSS: Main: 274522112 15:19:37 INFO - PROCESS | 26169 | 15:22:40 INFO - PROCESS | 26169 | Cycle 1(1): loaded http://localhost:33651/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33651/tests/dromaeo/cssquery-mootools.html) 15:22:40 INFO - PROCESS | 26169 | RSS: Main: 218259456 15:22:40 INFO - PROCESS | 26169 | 15:25:43 INFO - PROCESS | 26169 | Cycle 1(1): loaded http://localhost:33651/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33651/tests/dromaeo/cssquery-prototype.html) 15:25:43 INFO - PROCESS | 26169 | RSS: Main: 218583040 15:25:43 INFO - PROCESS | 26169 | 15:28:46 INFO - PROCESS | 26169 | Cycle 1(1): loaded http://localhost:33651/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33651/tests/dromaeo/cssquery-yui.html) 15:28:47 INFO - PROCESS | 26169 | RSS: Main: 219262976 15:28:47 INFO - PROCESS | 26169 | 15:31:50 INFO - PROCESS | 26169 | Cycle 1(1): loaded http://localhost:33651/tests/dromaeo/cssquery-yui.html (next: http://localhost:33651/tests/dromaeo/cssquery-dojo.html) 15:31:50 INFO - PROCESS | 26169 | RSS: Main: 310296576 15:31:50 INFO - PROCESS | 26169 | 15:31:50 INFO - PROCESS | 26169 | __start_tp_report 15:31:50 INFO - PROCESS | 26169 | _x_x_mozilla_page_load 15:31:50 INFO - PROCESS | 26169 | _x_x_mozilla_page_load_details 15:31:50 INFO - PROCESS | 26169 | |i|pagename|runs| 15:31:50 INFO - PROCESS | 26169 | |0;dojo.html;2572.164046684828;2576.446064096219;2599.1942497825676;2612.8301660392067;2621.5412302847;4579.564941330576;4581.977090114549;4622.8150873965005;4643.837465688702;4703.412073490814;4583.931241031387;4597.057603191346;4628;4649;4662.463816661077;4166.8749937501925;4191.350340697181;4230.4500414946015;4288.892777680568;4351.5648435156545;4245.893852653678;4302.182585308797;4328.956710432903;4349.847755328564;4353.238183317907;4204.26425375558;4254.489461264668;4269.380939763748;4271.209826182167;4357.4771027476745;4144.979275103636;4160.209560183555;4189.874303770892;4196.811143498519;4204.747715137101;4138.751674899516;4205.516365617963;4209.473815773028;4216.262154123016;4259.957400425987;4544.795484203219;4554.521775213588;4578.977105114486;4589.5410458954175;4651.534846515356;4852.587530059949;4922.926156107661;4924.778384972685;4926.236433352836;4930.137225985438;4925.950740492585;4928.67963582366;4929.4577596464715;4942.901141977176;5001.874953126165;4513.255312873404;4548.795304211319;4602.194615942197;4608.101420223092;4617.722936623813;4919.483454237254;4982.77577509013;5018.5985121190215;5026.195808670595;5091.032703786269;4826.903461930812;4836.854894353175;4844.733539655353;4848.660593758474;4896.779644915988;4764.857054288377;4914.483979182206;4915.65590408668;4928.408590969035;4977.751112444364;4738.691985020962;4855.660103792771;4900.754962251873;4921.557059864629;4980.601551875841;4881.170201065756;4885.682430641997;4899.289603007615;4902.058169103618;4963.106640804617;4075.0831063010587;4082.081531655354;4088.836446542105;4099.262132816122;4142.399352093929;3580.3555360035443;3605.729570282187;3616.7106631469946;3661.798601076913;3699.260147970363;4278.443802305743;4283.357496375568;4286.635635970977;4328.480582330078;4336.3278691802825;4952.876178095505;4961.355023846877;4966.553010229097;4969.627277954096;5022.221555658805;4235.724677895927;4252.723572967747;4267.957320426818;4279.2083464559155;4279.700420970502;4433.733975961452;4455.5989960903025;4500.414946057057;4508.1659892919915;4511.954880451219;4676.298555216745;4683.976580117078;4687.10944920464;4692.671512994058;4743.980044290494;4887.706737595756;4909.7545122743;4934.777934992862;4946.307516947558;4978.253262010582;4686.976565117153;4710.081534100817;4712.340272361941;4750.453697824794;4768.475467698481;4899.240617704261;4901.338319326987;4906.8773280668265;4922.606191504743;4964.602831773522;4863.440704319049;4899.951000489949;4909.729964851967;4995.075910956485;5057.266696329085;4788.018456216537;4825.4933232010135;4829.323894654822;4863.586595139312;4922.458529561817;4848.781804818721;4861.51384861511;4862.124817532878;4863.2461968394955;4926.753662316942;4799.736014519095;4807.78364973584;4814.325994360723;4814.5907597854575;4857.878553036202;4723.858284251478;4815.253635686474;4833.03339332128;4833.492483289345;4909.042736666316;4722.409698787652;4735.526447355237;4743.407074115736;4744.881377965578;4795.808167673394 15:31:50 INFO - PROCESS | 26169 | |1;ext.html;575.9948889188366;585.1486087742334;585.5403508246022;589.2045738253358;597.3339726205282;27378;36840;37813.62186378139;38022.61977380225;41377.17245655085;32947.83526082366;33221.33557328858;33231.50152747705;33233.33533329332;33254.8337258314;7405.111386633612;7574.35617972473;7580.431467639949;7583.696652133908;7591.051118610174;7510.8122296942465;7566.924330756677;7568.205338439439;7595.7721268361765;7599.506032107923;7573.356264717506;7586.886196707026;7601.8479630407355;7625.466217364787;7634.312911837934;7567.129780075306;7607.65765540552;7610.200928902441;7613.923860761377;7614.581198034106;7204.3155900189395;7263.201047884729;7263.745768898116;7266.091738532684;7269.63651817407;36178.63821361779;36509.63490365089;36539.08652283688;36555.81722091399;36585.81707091474;2700.932476688079;2755.4489102179646;2772.37621535153;2948.557716342544;3048.7713421493477;25230.495390092095;25563.74436255632;25644.35889102769;26132.216033519024;26461.867690661617;3307.1897385140555;3339.34882697874;3362.8318584070944;3369.3598216339064;3382.272811345548;243556;245213;245483;246078;246352.76823615946;30683.2329191772;31354.68645313518;31563.684363156535;32627.34745305128;43338;28425.28936776597;28436.289092772848;28501.857490712413;28507.57238641422;28509.857450712614;11827;11892.405379730979;11905.940470297593;11954.76090478203;11973.820392694117;9559.90440095604;9602.32783705148;9629.470379129216;9727.902720972841;9739.415635061778;7601.429892758065;7659.731909383145;7719.150893401721;7753.10839253493;7754.534727916343;2941.8529073546238;2982.507886198753;2986.357933044406;2997.955030674542;3054.1906394805396;811.4482152136604;899.8290324838259;910.9797027329301;933.1927882381826;977.94621295828;26248.86875565648;26956.59565106525;27293.626952009574;27447.588286175724;27644.72355276462;786.1588100732276;931.0782325497844;934.2105920497169;960.1071003966239;984.4487087231173;13335.333233338295;14143.151410915378;14246.643833904236;14287.64280892986;14404.711905761826;372907;375997;376846;378652;379065;46315.536844631126;46798;46836.7658161707;46921.29618055732;46923.29615055777;1063.2716589136467;1126.436781609179;1134.7560274541013;1153.861536615578;1154.6432941294113;26277.211683649522;27616.309592260353;28155;28358.43283134367;28688.569671455363;38978.80510597429;39523.60476395199;39627.60372396239;39646;39655.80172099121;286408;286997;287461;288054;288723;24231.75768242295;25334.493310133326;25366.1121860734;26099.217023489327;26165.345866353495;38789;39321.41017884791;39507;39866.80066599648;40483.59516404798;33873;34001.48997765085;34026;34150;34231.486527702604;34067.82966085154;34149.31701366008;34291;34515.82742086273;34951.82524087363;33905.32189356248;34267.4859877107;34485.82757086299;34722.13194670052;35101.297974039866;30052.69947300499;31077.533836992916;31392;31489.21276968094;31749.682503174674;23950.88024559866;23953.52092958166;24077.890839043037;24629.261122166365;24631.38421539476 15:31:50 INFO - PROCESS | 26169 | |2;jquery.html;330.6792411360982;357.54413123267847;364.75379119094606;366.46130188622715;378.45124569374394;12688.936555317223;13587.094399315529;13823.308834558282;16923.57691057724;16956.74564881528;14865.554033378989;15232.390704371812;15512;15553.455629052985;16087.115208663548;4330.675199360045;4455;4459.397981272536;4463.062756821071;4467.955320446803;3425.8972230833115;5119.846404607868;5281.551068159211;5365.597580181482;5401.756920938567;5388.622796404254;5396.19057141428;5398.838034858941;5399.568034557226;5401.297831281928;4760.880977975544;4979.327790748257;5003.149464591028;5045.369328833895;5050.368703912011;4842.595647262289;4905.411350637911;4914.287428322909;4914.533119353656;4915.803367865281;11450.828237576443;11803.11476639247;11811.114166437552;11819.172657913949;11823.94088029563;1804.1971322761376;1889.5748456597294;1901.3937593753465;1915.9137838797287;1979.5348093198088;8553.486790792573;8740.388172827905;8913.328874687262;9205.355625106245;9345;1730.4203091964207;1744.4069016534313;1755.1750677181703;1764.876458647895;1770.1060964213118;65844.3415565843;66372;71562.64218678873;71888.6405567974;71948.28051719468;9747.658831940847;9797.15882394112;9995.200383969264;10048.14590759779;10211.336263143021;13653.590392288248;13708.3831227595;13710.588682339545;13730.862691373159;13747.725045499034;6441.67791610427;6479.870402591921;6529.3470652935275;6614.66926653675;6674.899876501856;5943.940560594425;6093.512518998469;6127.203463549799;6169.5064394848305;6197.287311959182;4232.915341693149;4277.508086570084;4303.397524346594;4324.551275322802;4406.537313582092;1537.569480545449;1675.7570152327844;1746.9126543672764;1772.459399883048;1775.5028591994262;695.4957655699577;765.9157492675802;801.3148757812103;817.9631916563769;879.8944126704837;16752.1623918806;16768.6646267074;16915.968438944;16967.49097527076;17356.3057477702;841.8316336732678;866.2160744526213;897.9955100224457;929.0198840223494;933.3886304470583;9279.536023198812;9909.65316213929;9938.155256803107;9943.602255909827;9969.700908972598;393196;394408;396482;403546;407186;73071.63464182644;74783;75299;77273;78045;790.4150928313007;891.6166048599165;893.9865902011475;910.9180173784391;918.2883265469314;14065.718685626434;14995.250237487864;15141.242937853283;15739.89820712539;15741.212939352758;34171.65828341685;34757.47863782096;35571.822140890166;36272;38468.23063538769;49694;50467.242991354426;50566.2415063767;51717.482825172774;51719.74140129426;7291.817704557428;7368.37368823656;7561.962190189014;7622.54264744095;7679.884801727867;10915.454227288445;11291.209615326849;11585.594504192313;11864.762704745684;12093.697657558632;9959.601615935282;10211.438370889673;10359.792804143724;10530.947345263225;10964.56141754321;9835.508224588599;10083.193344532274;10310.381377117397;10391.896081039093;10645.574177032831;10202.642907498202;10213.33613315132;10415;10688;11063.612773552886;7294.890576641248;7434.888476672746;7476.177620461854;7512.5492470451945;7684.462087654034;8367.07557261821;9876.35803672759;10328.845067323846;10336.795593366081;10348.482575871327 15:31:50 INFO - PROCESS | 26169 | |3;mootools.html;1330.2417621955483;1374.2098293481247;1390.5202705066754;1569.7959265295524;1606.6545692676073;6628.469722422206;6856.554323968951;7078.504504684674;7629.618519074045;7633.73281935133;7349.522281051728;7585.658645360958;7606.163322034586;7608.771736847903;7618.9619051904665;2113.154738104759;2145.8497905146646;2148.3662319615673;2150.666646669769;2157.007776422847;1781.7238328059107;2105.8315334773256;2111.6410210264294;2113.165299706615;2125.7130287411155;2034.1964923855069;2095.025812996956;2097.0982477534653;2104.6527322991687;2105.105330234652;2086.447091520748;2109.040386624082;2109.831213502916;2112.42964399612;2131.5736852629534;2087.9478013049643;2131.467133216696;2132.1471411435396;2133.551954089643;2137.5724855029057;7594.278543538355;7657.770266892002;7663.808404789925;7670.156282808943;7678.424118191158;4198.32826747722;4319.352097185416;4324.178406102862;4325.243082460557;4329.177456283296;2743.341598016482;2919.3285544324713;2924.5613158026254;2931.8094323869095;2932.7213914678073;838.5932822581043;879.041844389612;883.4478450968145;885.9512726800024;903.0472851142042;10400.323978941344;10410.635627753069;10411.958804119604;10417.739556511073;10450.320729152581;3738.495303134042;3966.960330396659;4041.8787436376956;4065.5324637667045;4098.6516146127915;8915.063918288486;8922.241609463139;8923.553822308859;8929.464232146092;8934.329925255632;4356.760378179167;4357.2592659248;4359.869203923888;4364.62900653448;4365.126974605092;3872.593377695358;3923.803809809498;3927.4108883667677;3936.3701807710627;3937.842486300573;3423;3471.9826400867832;3521.207728261172;3523.224890524081;3538.5576802899636;1049.0715716590719;1144.6966553863233;1150.8734039255676;1161.512164890748;1175.9000484958874;655.8032590222914;664.6278084272823;665.3346653346654;698.7938558125365;765.7817522006313;5005.299258103868;5013.122703526941;5047.242913562922;5103.668261562986;5214.8957020860125;797.1908512859452;807.7899746065948;817.5013241922422;817.8854960305562;856.5845564901018;3358.748093892968;3571.1250743567994;3687.8893633191046;3711.0722319420147;3725.2177042821313;9222.123898229658;9643.614255429704;9643.903560964442;9644.517774111408;9670.323077384515;9539.52302384878;9558.330916835894;9559.713208603753;9561.330706850593;9565.952170239105;7196.424286057103;7213.278672132745;7230.313120253462;7356.337929586363;7368.078990126234;4961.156603377507;5073.16292811682;5188.636795424435;5368.141097424394;5522.22688823573;8545.477044920182;8599.312055035707;8635.6977505787;8638.697645582375;8661.740147795575;8601.784955375915;8704.129587041245;8957.552122393723;8978.775530611787;8989.685361012333;6386.904196436964;6606.4384527315715;6607.900881486878;6612.768553100618;6638.966805165944;7017.333353331425;7080.114985626797;7128.536645118051;7132.215456299699;7136.571805691675;6514.088027676224;6552.246491653521;6589;6662.133922590227;6678.899816502659;6295.5907865988565;6402.263739669811;6449.806505804833;6556.5738227017;6574.967125164535;5891.263592050994;5965.791197308074;6007.669578173068;6066.969665151646;6071.150038994632;4573.794179262008;4618.30725391194;4656.976715116402;4728.858134255978;4878.024395121061;4460.330950357472;4539.137563862855;4547.272436410159;4642.837500687459;4732.763361831826 15:31:50 INFO - PROCESS | 26169 | |4;prototype.html;285.3494033603384;290.4887398179204;292.7731008468438;296.20173632061596;298.9805662631929;4804.927926081112;4856.44150922644;4871.930683669283;4886.389201349832;4897.485763994782;4743.857684269469;4770.09368220038;4835.226363781796;4838.467768545457;4840.443349014864;3591.8204089795536;3695.907602309937;3704.0369503928905;3744.588095309514;3776.9055773605605;3759.135398858264;3769.754965927206;3780.962190378102;3787.704696913689;3794.4118661607495;3731.4589384539227;3748.7938163401004;3763.1344790698154;3769.6230376962358;3775.603561626031;3566.892993210208;3591.6947059499976;3705.962940370589;3722.324953770787;3748.306563285801;3297.950530742041;3300.834958252102;3307.4212012897888;3308.2060305526743;3309.8841540546205;4592.2193227151465;4629.3750343703505;4637;4657.92722238604;4680.461746899082;4196.328587426027;4254.978725106354;4261.4673165854265;4296.205202037601;4312.2022425851;4944.431390390079;4958.355413796184;4982.277569752402;4984.2025275955675;4985.152524070881;3597.6222496638;3599.5860476045327;3603.4865356550313;3611.855525778966;3614.2410093880317;4947.381577302837;5278.498542638443;5284.788608455658;5285.339332583427;5296.761645725952;3541.7166626669805;3571.2857428514403;3574.4638304254568;3601.5689409648385;3608.8376023079027;3624.9637503625154;3629.0745859806107;3629.909252268714;3642.7450078494253;3643.908902277464;4190.245755763992;4193.308104162779;4196.265653510623;4203.91592168155;4205.243056249905;4879.682820616648;5016.423111342169;5034.194528875362;5053.545180933734;5057.949420505748;1267.4930027988878;1283.3903895649491;1285.7042880137433;1286.1961274203622;1289.6517940156104;809.7368355284556;812.8455593437346;814.5031530766228;816.5182542300072;858.965641374338;4376.124775045004;4394.12117576486;4404.647628189737;4405.31717583775;4430.224710675619;5088.414832294259;5094.261332106824;5100.872478188001;5103.693778373309;5113.207452844815;4282.785860707015;4386.758728269912;4390.846320378771;4413.646908247332;4419.315006174048;2701.18964310706;2705.201965420206;2705.6482657254433;2711.7492481240524;2714.9864250679016;4783.091212669582;4798.328234047236;4815.7351345676325;4818.494058123846;4828.348172996671;5076.238564215398;5129.724844048627;5224.843254702365;5227.529522343008;5229.450907654642;4749.430068391746;4757.500462451531;4787.736674482937;4815.3499277597775;4833.685810422311;5051.469595692546;5062.645614806928;5067.771950262173;5127.743702792691;5133.974330128325;4805.9038819224115;5009.17165234694;5010.396673064584;5020.598352131894;5020.799168033238;4755.1916174251155;4777.355057067251;4812.205986012409;4821.590164836029;4840.564349208588;3612.060864175386;3625.4018087015347;3629.909252268714;3647.598764135996;3655.2506736119562;4832.347633069631;5046.233818163761;5072.391313042459;5148.639595228298;5164.225366194951;4881.31661567388;4925.975370123127;4929.827456039022;4947.802087916443;4951.356323677899;4915.680480768739;4954;4954.479779623088;4957.157283261926;4966.553010229097;4675.929861052155;4792.712437253636;4840.419149701917;4850.902981940412;4861.708297502161;4810.663253572357;4939.75301234944;5009;5046.568333533232;5055.292259083805;4879.853604391874;4949.480304567968;4955.331030310862;4956.256561515802;4966.1941003333 15:31:50 INFO - PROCESS | 26169 | |5;yui.html;593.7387549478229;599.2988203801552;612.7548980407836;621.2793159934477;626.1265534579262;11712.648620541388;12151.817722734166;12803.679908002305;12809;12825.551105711302;12712.872871271307;12884.871151288484;12923.806142907864;12968.027397945145;12969.93515032426;624.0763669768745;746.1754760989097;767.45510687412;772.8570214510333;772.9574873381962;744.7021191523407;754.811297175706;761.2045412543878;777.2810150610691;778.1829079466537;813.4631143445328;818.3616778912428;820.5692011693878;820.7250571058703;820.9466384684977;649.9675016249168;811.9878201826978;812.1513018895268;812.6546217857416;812.8008637883727;566.3317285602986;570.8344580071774;575.5309422820429;588.5703436491342;588.6203398807745;11764.764704705944;11830.763384732343;11881.821772673416;11915.285082895054;11930.821037684442;11304.547818087267;11754.588589399416;11768;11850.88149118515;12733.87266127336;9009.414388064755;9063.41087829289;9065;9190.35667503275;9332.533373331305;3989.1024519483176;4044.534878488982;4071.97964010181;4073.674106071507;4100.876973690794;64218.67890660517;64297.35702642961;64308.67845660742;64314.3568564313;64401.08579912684;9383.155516003593;9539.18916892058;9884.209263258923;9951.651692190739;10212.285140040125;19039.428817135507;19155.90422047881;19165.425037248904;19186.328478503186;19246.518837028907;6538.705758240891;6575.473962083118;6608.2730899601;6653.500987425962;6748;3591.317649646559;3592.820358982093;3610;3650.817459127033;3658.981705091511;2607.4654695787317;2684.1410748560274;2690.2736261209366;2693.0843513205605;2703.405250844811;486.8028448478301;487.3104557051803;495.7124867576797;498.64097849548267;505.69152816781735;472.1030042918482;477.6632474105747;487.73174753885223;491.6582974832457;518.2873548870303;7166.319199676022;7363.9631801841715;7376.906166032766;7675.347595454449;7762.417818663623;408.5179488203888;418.98533551325556;429.7013575565015;430.15474592426034;446.2703479810468;3542.71658267338;3558.430651095812;3635.8545658173375;3711;3715.5727091384297;98528.50735746419;100246.49876750716;101452.49273753584;102996.48501757444;103303.4834825821;86359.56820215858;89630.75923101975;89929.55035224782;90220;92527;58602.70698646479;75455.68589035599;75991;76978.6151069241;79281;6748.325167483409;6835.658217089225;6957.095577574883;7037.366637002694;7252.2747725227055;46951.29573056338;47594;47699.5230047709;48416.27375589439;48879.511204887494;37323;52927;55566.44433555612;56057.43942560522;60684.6965765186;10593;10740.570377185139;10978.505967231335;11161.720956975816;11528.423578821194;12417.254964702146;12494.812577811159;12543.372831358578;12662.240265584094;12724.618261452171;11457.656270311903;11466;11966.880331196577;12020.459079341626;12047.75904481923;11481.425928703698;11550.249233799776;11627.418629068343;12020.519179233082;12476.937615312228;10091.243156763125;10737.302075365076;10970.561177553127;11076.280041797258;11152;9717.611295548098;9771.31600787938;9774.951125244328;9956.800863982824;10104.141148002209;8496.660133594587;8960.775980600538;9329.813403732023;9492.335536512654;9624.37441566296 15:31:50 INFO - PROCESS | 26169 | __end_tp_report 15:31:50 INFO - PROCESS | 26169 | __start_cc_report 15:31:50 INFO - PROCESS | 26169 | _x_x_mozilla_cycle_collect,1174 15:31:50 INFO - PROCESS | 26169 | __end_cc_report 15:31:50 INFO - PROCESS | 26169 | __startTimestamp1471991510753__endTimestamp 15:31:50 INFO - PROCESS | 26169 | 15:31:50 INFO - PROCESS | 26169 | ------- Summary: start ------- 15:31:50 INFO - PROCESS | 26169 | Number of tests: 6 15:31:50 INFO - PROCESS | 26169 | 15:31:50 INFO - PROCESS | 26169 | [#0] dojo.html Cycles:165 Average:4566.90 Median:4722.41 stddev:479.56 (10.2%) stddev-sans-first:454.78 15:31:50 INFO - PROCESS | 26169 | Values: 2572.2 2576.4 2599.2 2612.8 2621.5 4579.6 4582.0 4622.8 4643.8 4703.4 4583.9 4597.1 4628.0 4649.0 4662.5 4166.9 4191.4 4230.5 4288.9 4351.6 4245.9 4302.2 4329.0 4349.8 4353.2 4204.3 4254.5 4269.4 4271.2 4357.5 4145.0 4160.2 4189.9 4196.8 4204.7 4138.8 4205.5 4209.5 4216.3 4260.0 4544.8 4554.5 4579.0 4589.5 4651.5 4852.6 4922.9 4924.8 4926.2 4930.1 4926.0 4928.7 4929.5 4942.9 5001.9 4513.3 4548.8 4602.2 4608.1 4617.7 4919.5 4982.8 5018.6 5026.2 5091.0 4826.9 4836.9 4844.7 4848.7 4896.8 4764.9 4914.5 4915.7 4928.4 4977.8 4738.7 4855.7 4900.8 4921.6 4980.6 4881.2 4885.7 4899.3 4902.1 4963.1 4075.1 4082.1 4088.8 4099.3 4142.4 3580.4 3605.7 3616.7 3661.8 3699.3 4278.4 4283.4 4286.6 4328.5 4336.3 4952.9 4961.4 4966.6 4969.6 5022.2 4235.7 4252.7 4268.0 4279.2 4279.7 4433.7 4455.6 4500.4 4508.2 4512.0 4676.3 4684.0 4687.1 4692.7 4744.0 4887.7 4909.8 4934.8 4946.3 4978.3 4687.0 4710.1 4712.3 4750.5 4768.5 4899.2 4901.3 4906.9 4922.6 4964.6 4863.4 4900.0 4909.7 4995.1 5057.3 4788.0 4825.5 4829.3 4863.6 4922.5 4848.8 4861.5 4862.1 4863.2 4926.8 4799.7 4807.8 4814.3 4814.6 4857.9 4723.9 4815.3 4833.0 4833.5 4909.0 4722.4 4735.5 4743.4 4744.9 4795.8 15:31:50 INFO - PROCESS | 26169 | 15:31:50 INFO - PROCESS | 26169 | [#1] ext.html Cycles:180 Average:43386.26 Median:34149.66 stddev:81328.38 (238.2%) stddev-sans-first:81493.01 15:31:50 INFO - PROCESS | 26169 | Values: 576.0 585.1 585.5 589.2 597.3 27378.0 36840.0 37813.6 38022.6 41377.2 32947.8 33221.3 33231.5 33233.3 33254.8 7405.1 7574.4 7580.4 7583.7 7591.1 7510.8 7566.9 7568.2 7595.8 7599.5 7573.4 7586.9 7601.8 7625.5 7634.3 7567.1 7607.7 7610.2 7613.9 7614.6 7204.3 7263.2 7263.7 7266.1 7269.6 36178.6 36509.6 36539.1 36555.8 36585.8 2700.9 2755.4 2772.4 2948.6 3048.8 25230.5 25563.7 25644.4 26132.2 26461.9 3307.2 3339.3 3362.8 3369.4 3382.3 243556.0 245213.0 245483.0 246078.0 246352.8 30683.2 31354.7 31563.7 32627.3 43338.0 28425.3 28436.3 28501.9 28507.6 28509.9 11827.0 11892.4 11905.9 11954.8 11973.8 9559.9 9602.3 9629.5 9727.9 9739.4 7601.4 7659.7 7719.2 7753.1 7754.5 2941.9 2982.5 2986.4 2998.0 3054.2 811.4 899.8 911.0 933.2 977.9 26248.9 26956.6 27293.6 27447.6 27644.7 786.2 931.1 934.2 960.1 984.4 13335.3 14143.2 14246.6 14287.6 14404.7 372907.0 375997.0 376846.0 378652.0 379065.0 46315.5 46798.0 46836.8 46921.3 46923.3 1063.3 1126.4 1134.8 1153.9 1154.6 26277.2 27616.3 28155.0 28358.4 28688.6 38978.8 39523.6 39627.6 39646.0 39655.8 286408.0 286997.0 287461.0 288054.0 288723.0 24231.8 25334.5 25366.1 26099.2 26165.3 38789.0 39321.4 39507.0 39866.8 40483.6 33873.0 34001.5 34026.0 34150.0 34231.5 34067.8 34149.3 34291.0 34515.8 34951.8 33905.3 34267.5 34485.8 34722.1 35101.3 30052.7 31077.5 31392.0 31489.2 31749.7 23950.9 23953.5 24077.9 24629.3 24631.4 15:31:50 INFO - PROCESS | 26169 | 15:31:50 INFO - PROCESS | 26169 | [#2] jquery.html Cycles:180 Average:24021.96 Median:4457.20 stddev:65874.86 (1477.9%) stddev-sans-first:66035.64 15:31:50 INFO - PROCESS | 26169 | Values: 330.7 357.5 364.8 366.5 378.5 12688.9 13587.1 13823.3 16923.6 16956.7 14865.6 15232.4 15512.0 15553.5 16087.1 4330.7 4455.0 4459.4 4463.1 4468.0 3425.9 5119.8 5281.6 5365.6 5401.8 5388.6 5396.2 5398.8 5399.6 5401.3 4760.9 4979.3 5003.1 5045.4 5050.4 4842.6 4905.4 4914.3 4914.5 4915.8 11450.8 11803.1 11811.1 11819.2 11823.9 1804.2 1889.6 1901.4 1915.9 1979.5 8553.5 8740.4 8913.3 9205.4 9345.0 1730.4 1744.4 1755.2 1764.9 1770.1 65844.3 66372.0 71562.6 71888.6 71948.3 9747.7 9797.2 9995.2 10048.1 10211.3 13653.6 13708.4 13710.6 13730.9 13747.7 6441.7 6479.9 6529.3 6614.7 6674.9 5943.9 6093.5 6127.2 6169.5 6197.3 4232.9 4277.5 4303.4 4324.6 4406.5 1537.6 1675.8 1746.9 1772.5 1775.5 695.5 765.9 801.3 818.0 879.9 16752.2 16768.7 16916.0 16967.5 17356.3 841.8 866.2 898.0 929.0 933.4 9279.5 9909.7 9938.2 9943.6 9969.7 393196.0 394408.0 396482.0 403546.0 407186.0 73071.6 74783.0 75299.0 77273.0 78045.0 790.4 891.6 894.0 910.9 918.3 14065.7 14995.3 15141.2 15739.9 15741.2 34171.7 34757.5 35571.8 36272.0 38468.2 49694.0 50467.2 50566.2 51717.5 51719.7 7291.8 7368.4 7562.0 7622.5 7679.9 10915.5 11291.2 11585.6 11864.8 12093.7 9959.6 10211.4 10359.8 10530.9 10964.6 9835.5 10083.2 10310.4 10391.9 10645.6 10202.6 10213.3 10415.0 10688.0 11063.6 7294.9 7434.9 7476.2 7512.5 7684.5 8367.1 9876.4 10328.8 10336.8 10348.5 15:31:50 INFO - PROCESS | 26169 | 15:31:50 INFO - PROCESS | 26169 | [#3] mootools.html Cycles:180 Average:4997.83 Median:5146.15 stddev:2822.59 (54.8%) stddev-sans-first:2817.05 15:31:50 INFO - PROCESS | 26169 | Values: 1330.2 1374.2 1390.5 1569.8 1606.7 6628.5 6856.6 7078.5 7629.6 7633.7 7349.5 7585.7 7606.2 7608.8 7619.0 2113.2 2145.8 2148.4 2150.7 2157.0 1781.7 2105.8 2111.6 2113.2 2125.7 2034.2 2095.0 2097.1 2104.7 2105.1 2086.4 2109.0 2109.8 2112.4 2131.6 2087.9 2131.5 2132.1 2133.6 2137.6 7594.3 7657.8 7663.8 7670.2 7678.4 4198.3 4319.4 4324.2 4325.2 4329.2 2743.3 2919.3 2924.6 2931.8 2932.7 838.6 879.0 883.4 886.0 903.0 10400.3 10410.6 10412.0 10417.7 10450.3 3738.5 3967.0 4041.9 4065.5 4098.7 8915.1 8922.2 8923.6 8929.5 8934.3 4356.8 4357.3 4359.9 4364.6 4365.1 3872.6 3923.8 3927.4 3936.4 3937.8 3423.0 3472.0 3521.2 3523.2 3538.6 1049.1 1144.7 1150.9 1161.5 1175.9 655.8 664.6 665.3 698.8 765.8 5005.3 5013.1 5047.2 5103.7 5214.9 797.2 807.8 817.5 817.9 856.6 3358.7 3571.1 3687.9 3711.1 3725.2 9222.1 9643.6 9643.9 9644.5 9670.3 9539.5 9558.3 9559.7 9561.3 9566.0 7196.4 7213.3 7230.3 7356.3 7368.1 4961.2 5073.2 5188.6 5368.1 5522.2 8545.5 8599.3 8635.7 8638.7 8661.7 8601.8 8704.1 8957.6 8978.8 8989.7 6386.9 6606.4 6607.9 6612.8 6639.0 7017.3 7080.1 7128.5 7132.2 7136.6 6514.1 6552.2 6589.0 6662.1 6678.9 6295.6 6402.3 6449.8 6556.6 6575.0 5891.3 5965.8 6007.7 6067.0 6071.2 4573.8 4618.3 4657.0 4728.9 4878.0 4460.3 4539.1 4547.3 4642.8 4732.8 15:31:50 INFO - PROCESS | 26169 | 15:31:50 INFO - PROCESS | 26169 | [#4] prototype.html Cycles:180 Average:4136.24 Median:4773.72 stddev:1197.77 (25.1%) stddev-sans-first:1165.74 15:31:50 INFO - PROCESS | 26169 | Values: 285.3 290.5 292.8 296.2 299.0 4804.9 4856.4 4871.9 4886.4 4897.5 4743.9 4770.1 4835.2 4838.5 4840.4 3591.8 3695.9 3704.0 3744.6 3776.9 3759.1 3769.8 3781.0 3787.7 3794.4 3731.5 3748.8 3763.1 3769.6 3775.6 3566.9 3591.7 3706.0 3722.3 3748.3 3298.0 3300.8 3307.4 3308.2 3309.9 4592.2 4629.4 4637.0 4657.9 4680.5 4196.3 4255.0 4261.5 4296.2 4312.2 4944.4 4958.4 4982.3 4984.2 4985.2 3597.6 3599.6 3603.5 3611.9 3614.2 4947.4 5278.5 5284.8 5285.3 5296.8 3541.7 3571.3 3574.5 3601.6 3608.8 3625.0 3629.1 3629.9 3642.7 3643.9 4190.2 4193.3 4196.3 4203.9 4205.2 4879.7 5016.4 5034.2 5053.5 5057.9 1267.5 1283.4 1285.7 1286.2 1289.7 809.7 812.8 814.5 816.5 859.0 4376.1 4394.1 4404.6 4405.3 4430.2 5088.4 5094.3 5100.9 5103.7 5113.2 4282.8 4386.8 4390.8 4413.6 4419.3 2701.2 2705.2 2705.6 2711.7 2715.0 4783.1 4798.3 4815.7 4818.5 4828.3 5076.2 5129.7 5224.8 5227.5 5229.5 4749.4 4757.5 4787.7 4815.3 4833.7 5051.5 5062.6 5067.8 5127.7 5134.0 4805.9 5009.2 5010.4 5020.6 5020.8 4755.2 4777.4 4812.2 4821.6 4840.6 3612.1 3625.4 3629.9 3647.6 3655.3 4832.3 5046.2 5072.4 5148.6 5164.2 4881.3 4926.0 4929.8 4947.8 4951.4 4915.7 4954.0 4954.5 4957.2 4966.6 4675.9 4792.7 4840.4 4850.9 4861.7 4810.7 4939.8 5009.0 5046.6 5055.3 4879.9 4949.5 4955.3 4956.3 4966.2 15:31:50 INFO - PROCESS | 26169 | 15:31:50 INFO - PROCESS | 26169 | [#5] yui.html Cycles:180 Average:17611.10 Median:24683.62 stddev:25914.10 (105.0%) stddev-sans-first:25955.29 15:31:50 INFO - PROCESS | 26169 | Values: 593.7 599.3 612.8 621.3 626.1 11712.6 12151.8 12803.7 12809.0 12825.6 12712.9 12884.9 12923.8 12968.0 12969.9 624.1 746.2 767.5 772.9 773.0 744.7 754.8 761.2 777.3 778.2 813.5 818.4 820.6 820.7 820.9 650.0 812.0 812.2 812.7 812.8 566.3 570.8 575.5 588.6 588.6 11764.8 11830.8 11881.8 11915.3 11930.8 11304.5 11754.6 11768.0 11850.9 12733.9 9009.4 9063.4 9065.0 9190.4 9332.5 3989.1 4044.5 4072.0 4073.7 4100.9 64218.7 64297.4 64308.7 64314.4 64401.1 9383.2 9539.2 9884.2 9951.7 10212.3 19039.4 19155.9 19165.4 19186.3 19246.5 6538.7 6575.5 6608.3 6653.5 6748.0 3591.3 3592.8 3610.0 3650.8 3659.0 2607.5 2684.1 2690.3 2693.1 2703.4 486.8 487.3 495.7 498.6 505.7 472.1 477.7 487.7 491.7 518.3 7166.3 7364.0 7376.9 7675.3 7762.4 408.5 419.0 429.7 430.2 446.3 3542.7 3558.4 3635.9 3711.0 3715.6 98528.5 100246.5 101452.5 102996.5 103303.5 86359.6 89630.8 89929.6 90220.0 92527.0 58602.7 75455.7 75991.0 76978.6 79281.0 6748.3 6835.7 6957.1 7037.4 7252.3 46951.3 47594.0 47699.5 48416.3 48879.5 37323.0 52927.0 55566.4 56057.4 60684.7 10593.0 10740.6 10978.5 11161.7 11528.4 12417.3 12494.8 12543.4 12662.2 12724.6 11457.7 11466.0 11966.9 12020.5 12047.8 11481.4 11550.2 11627.4 12020.5 12476.9 10091.2 10737.3 10970.6 11076.3 11152.0 9717.6 9771.3 9775.0 9956.8 10104.1 8496.7 8960.8 9329.8 9492.3 9624.4 15:31:50 INFO - PROCESS | 26169 | -------- Summary: end -------- 15:31:50 INFO - PROCESS | 26169 | 15:31:51 INFO - TEST-INFO | 26169: exit 0 15:31:51 INFO - TEST-OK | dromaeo_css | took 1122047ms 15:31:51 INFO - TEST-START | kraken 15:31:51 INFO - operating with platform_type : linux_ 15:31:51 INFO - Initialising browser for kraken test... 15:31:51 INFO - TEST-INFO | started process 26475 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTWpfzM/profile http://localhost:33651/getInfo.html) 15:31:56 INFO - PROCESS | 26475 | __metrics Screen width/height:1600/1200 15:31:56 INFO - PROCESS | 26475 | colorDepth:24 15:31:56 INFO - PROCESS | 26475 | Browser inner width/height: 1024/697 15:31:56 INFO - PROCESS | 26475 | __metrics 15:31:57 INFO - PROCESS | 26475 | 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" 15:31:57 INFO - PROCESS | 26475 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:31:58 INFO - TEST-INFO | 26475: exit 0 15:31:58 INFO - Browser initialized. 15:31:58 INFO - Running cycle 1/1 for kraken test... 15:31:58 INFO - TEST-INFO | started process 26556 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTWpfzM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:32:10 INFO - PROCESS | 26556 | RSS: Main: 182599680 15:32:10 INFO - PROCESS | 26556 | 15:32:13 INFO - PROCESS | 26556 | Cycle 1(1): loaded http://localhost:33651/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33651/tests/kraken/driver.html?testName=audio-beat-detection) 15:32:14 INFO - PROCESS | 26556 | RSS: Main: 245198848 15:32:14 INFO - PROCESS | 26556 | 15:32:16 INFO - PROCESS | 26556 | Cycle 1(1): loaded http://localhost:33651/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33651/tests/kraken/driver.html?testName=audio-dft) 15:32:17 INFO - PROCESS | 26556 | RSS: Main: 226938880 15:32:17 INFO - PROCESS | 26556 | 15:32:20 INFO - PROCESS | 26556 | Cycle 1(1): loaded http://localhost:33651/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33651/tests/kraken/driver.html?testName=audio-fft) 15:32:21 INFO - PROCESS | 26556 | RSS: Main: 305926144 15:32:21 INFO - PROCESS | 26556 | 15:32:23 INFO - PROCESS | 26556 | Cycle 1(1): loaded http://localhost:33651/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33651/tests/kraken/driver.html?testName=audio-oscillator) 15:32:24 INFO - PROCESS | 26556 | RSS: Main: 214511616 15:32:24 INFO - PROCESS | 26556 | 15:32:26 INFO - PROCESS | 26556 | Cycle 1(1): loaded http://localhost:33651/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33651/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:32:27 INFO - PROCESS | 26556 | RSS: Main: 215900160 15:32:27 INFO - PROCESS | 26556 | 15:32:30 INFO - PROCESS | 26556 | Cycle 1(1): loaded http://localhost:33651/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33651/tests/kraken/driver.html?testName=imaging-darkroom) 15:32:31 INFO - PROCESS | 26556 | RSS: Main: 254177280 15:32:31 INFO - PROCESS | 26556 | 15:32:34 INFO - PROCESS | 26556 | Cycle 1(1): loaded http://localhost:33651/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33651/tests/kraken/driver.html?testName=imaging-desaturate) 15:32:35 INFO - PROCESS | 26556 | RSS: Main: 248061952 15:32:35 INFO - PROCESS | 26556 | 15:32:38 INFO - PROCESS | 26556 | Cycle 1(1): loaded http://localhost:33651/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33651/tests/kraken/driver.html?testName=json-parse-financial) 15:32:38 INFO - PROCESS | 26556 | RSS: Main: 251006976 15:32:38 INFO - PROCESS | 26556 | 15:32:40 INFO - PROCESS | 26556 | Cycle 1(1): loaded http://localhost:33651/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33651/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:32:41 INFO - PROCESS | 26556 | RSS: Main: 215306240 15:32:41 INFO - PROCESS | 26556 | 15:32:43 INFO - PROCESS | 26556 | Cycle 1(1): loaded http://localhost:33651/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33651/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:32:43 INFO - PROCESS | 26556 | RSS: Main: 222613504 15:32:43 INFO - PROCESS | 26556 | 15:32:45 INFO - PROCESS | 26556 | Cycle 1(1): loaded http://localhost:33651/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33651/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:32:46 INFO - PROCESS | 26556 | RSS: Main: 223379456 15:32:46 INFO - PROCESS | 26556 | 15:32:49 INFO - PROCESS | 26556 | Cycle 1(1): loaded http://localhost:33651/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33651/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:32:50 INFO - PROCESS | 26556 | RSS: Main: 219500544 15:32:50 INFO - PROCESS | 26556 | 15:32:53 INFO - PROCESS | 26556 | Cycle 1(1): loaded http://localhost:33651/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33651/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:32:53 INFO - PROCESS | 26556 | RSS: Main: 222130176 15:32:53 INFO - PROCESS | 26556 | 15:32:55 INFO - PROCESS | 26556 | Cycle 1(1): loaded http://localhost:33651/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33651/tests/kraken/driver.html?testName=ai-astar) 15:32:55 INFO - PROCESS | 26556 | RSS: Main: 273829888 15:32:55 INFO - PROCESS | 26556 | 15:32:55 INFO - PROCESS | 26556 | __start_tp_report 15:32:55 INFO - PROCESS | 26556 | _x_x_mozilla_page_load 15:32:55 INFO - PROCESS | 26556 | _x_x_mozilla_page_load_details 15:32:55 INFO - PROCESS | 26556 | |i|pagename|runs| 15:32:55 INFO - PROCESS | 26556 | |0;ai-astar;114;115;127;114;112;115;114;117;116;114 15:32:55 INFO - PROCESS | 26556 | |1;audio-beat-detection;150;125;148;188;123;146;145;124;187;127 15:32:55 INFO - PROCESS | 26556 | |2;audio-dft;162;161;161;162;161;161;161;162;160;161 15:32:55 INFO - PROCESS | 26556 | |3;audio-fft;75;76;77;166;78;76;75;75;171;75 15:32:55 INFO - PROCESS | 26556 | |4;audio-oscillator;86;87;146;87;88;87;145;86;85;142 15:32:55 INFO - PROCESS | 26556 | |5;imaging-gaussian-blur;118;118;118;117;117;117;117;117;117;117 15:32:55 INFO - PROCESS | 26556 | |6;imaging-darkroom;147;146;147;145;148;146;145;147;148;146 15:32:55 INFO - PROCESS | 26556 | |7;imaging-desaturate;95;96;95;95;95;94;94;95;95;95 15:32:55 INFO - PROCESS | 26556 | |8;json-parse-financial;66;65;67;70;66;66;66;66;65;66 15:32:55 INFO - PROCESS | 26556 | |9;json-stringify-tinderbox;65;66;66;65;67;66;65;66;66;67 15:32:55 INFO - PROCESS | 26556 | |10;stanford-crypto-aes;84;83;84;84;86;89;83;84;85;83 15:32:55 INFO - PROCESS | 26556 | |11;stanford-crypto-ccm;143;131;147;131;131;132;145;133;151;136 15:32:55 INFO - PROCESS | 26556 | |12;stanford-crypto-pbkdf2;175;174;177;172;174;178;178;173;179;176 15:32:55 INFO - PROCESS | 26556 | |13;stanford-crypto-sha256-iterative;68;69;71;69;68;69;69;69;67;69 15:32:55 INFO - PROCESS | 26556 | __end_tp_report 15:32:55 INFO - PROCESS | 26556 | __start_cc_report 15:32:55 INFO - PROCESS | 26556 | _x_x_mozilla_cycle_collect,2031 15:32:55 INFO - PROCESS | 26556 | __end_cc_report 15:32:55 INFO - PROCESS | 26556 | __startTimestamp1471991575822__endTimestamp 15:32:55 INFO - PROCESS | 26556 | 15:32:55 INFO - PROCESS | 26556 | ------- Summary: start ------- 15:32:55 INFO - PROCESS | 26556 | Number of tests: 14 15:32:55 INFO - PROCESS | 26556 | 15:32:55 INFO - PROCESS | 26556 | [#0] ai-astar Cycles:10 Average:115.80 Median:115.00 stddev:4.16 (3.6%) stddev-sans-first:4.36 15:32:55 INFO - PROCESS | 26556 | Values: 114.0 115.0 127.0 114.0 112.0 115.0 114.0 117.0 116.0 114.0 15:32:55 INFO - PROCESS | 26556 | 15:32:55 INFO - PROCESS | 26556 | [#1] audio-beat-detection Cycles:10 Average:146.30 Median:147.00 stddev:24.22 (16.5%) stddev-sans-first:25.65 15:32:55 INFO - PROCESS | 26556 | Values: 150.0 125.0 148.0 188.0 123.0 146.0 145.0 124.0 187.0 127.0 15:32:55 INFO - PROCESS | 26556 | 15:32:55 INFO - PROCESS | 26556 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 15:32:55 INFO - PROCESS | 26556 | Values: 162.0 161.0 161.0 162.0 161.0 161.0 161.0 162.0 160.0 161.0 15:32:55 INFO - PROCESS | 26556 | 15:32:55 INFO - PROCESS | 26556 | [#3] audio-fft Cycles:10 Average:94.40 Median:75.50 stddev:39.08 (51.8%) stddev-sans-first:40.82 15:32:55 INFO - PROCESS | 26556 | Values: 75.0 76.0 77.0 166.0 78.0 76.0 75.0 75.0 171.0 75.0 15:32:55 INFO - PROCESS | 26556 | 15:32:55 INFO - PROCESS | 26556 | [#4] audio-oscillator Cycles:10 Average:103.90 Median:86.50 stddev:27.93 (32.3%) stddev-sans-first:28.86 15:32:55 INFO - PROCESS | 26556 | Values: 86.0 87.0 146.0 87.0 88.0 87.0 145.0 86.0 85.0 142.0 15:32:55 INFO - PROCESS | 26556 | 15:32:55 INFO - PROCESS | 26556 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 15:32:55 INFO - PROCESS | 26556 | Values: 118.0 118.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 15:32:55 INFO - PROCESS | 26556 | 15:32:55 INFO - PROCESS | 26556 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:1.08 (0.7%) stddev-sans-first:1.13 15:32:55 INFO - PROCESS | 26556 | Values: 147.0 146.0 147.0 145.0 148.0 146.0 145.0 147.0 148.0 146.0 15:32:55 INFO - PROCESS | 26556 | 15:32:55 INFO - PROCESS | 26556 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 15:32:55 INFO - PROCESS | 26556 | Values: 95.0 96.0 95.0 95.0 95.0 94.0 94.0 95.0 95.0 95.0 15:32:55 INFO - PROCESS | 26556 | 15:32:55 INFO - PROCESS | 26556 | [#8] json-parse-financial Cycles:10 Average:66.30 Median:66.00 stddev:1.42 (2.1%) stddev-sans-first:1.50 15:32:55 INFO - PROCESS | 26556 | Values: 66.0 65.0 67.0 70.0 66.0 66.0 66.0 66.0 65.0 66.0 15:32:55 INFO - PROCESS | 26556 | 15:32:55 INFO - PROCESS | 26556 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 15:32:55 INFO - PROCESS | 26556 | Values: 65.0 66.0 66.0 65.0 67.0 66.0 65.0 66.0 66.0 67.0 15:32:55 INFO - PROCESS | 26556 | 15:32:55 INFO - PROCESS | 26556 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:84.00 stddev:1.84 (2.2%) stddev-sans-first:1.94 15:32:55 INFO - PROCESS | 26556 | Values: 84.0 83.0 84.0 84.0 86.0 89.0 83.0 84.0 85.0 83.0 15:32:55 INFO - PROCESS | 26556 | 15:32:55 INFO - PROCESS | 26556 | [#11] stanford-crypto-ccm Cycles:10 Average:138.00 Median:139.50 stddev:7.72 (5.5%) stddev-sans-first:7.97 15:32:55 INFO - PROCESS | 26556 | Values: 143.0 131.0 147.0 131.0 131.0 132.0 145.0 133.0 151.0 136.0 15:32:55 INFO - PROCESS | 26556 | 15:32:55 INFO - PROCESS | 26556 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.60 Median:176.50 stddev:2.37 (1.3%) stddev-sans-first:2.50 15:32:55 INFO - PROCESS | 26556 | Values: 175.0 174.0 177.0 172.0 174.0 178.0 178.0 173.0 179.0 176.0 15:32:55 INFO - PROCESS | 26556 | 15:32:55 INFO - PROCESS | 26556 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:1.03 (1.5%) stddev-sans-first:1.05 15:32:55 INFO - PROCESS | 26556 | Values: 68.0 69.0 71.0 69.0 68.0 69.0 69.0 69.0 67.0 69.0 15:32:55 INFO - PROCESS | 26556 | -------- Summary: end -------- 15:32:55 INFO - PROCESS | 26556 | 15:32:57 INFO - TEST-INFO | 26556: exit 0 15:32:57 INFO - TEST-OK | kraken | took 65364ms 15:32:57 INFO - SUITE-END | took 1187s 15:32:57 INFO - Completed test suite (00:19:47) 15:32:57 INFO - javascript benchmark 15:32:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2572.164046684828, 2576.446064096219, 2599.1942497825676, 2612.8301660392067, 2621.5412302847, 4579.564941330576, 4581.977090114549, 4622.8150873965005, 4643.837465688702, 4703.412073490814, 4583.931241031387, 4597.057603191346, 4628.0, 4649.0, 4662.463816661077, 4166.8749937501925, 4191.350340697181, 4230.4500414946015, 4288.892777680568, 4351.5648435156545, 4245.893852653678, 4302.182585308797, 4328.956710432903, 4349.847755328564, 4353.238183317907, 4204.26425375558, 4254.489461264668, 4269.380939763748, 4271.209826182167, 4357.4771027476745, 4144.979275103636, 4160.209560183555, 4189.874303770892, 4196.811143498519, 4204.747715137101, 4138.751674899516, 4205.516365617963, 4209.473815773028, 4216.262154123016, 4259.957400425987, 4544.795484203219, 4554.521775213588, 4578.977105114486, 4589.5410458954175, 4651.534846515356, 4852.587530059949, 4922.926156107661, 4924.778384972685, 4926.236433352836, 4930.137225985438, 4925.950740492585, 4928.67963582366, 4929.4577596464715, 4942.901141977176, 5001.874953126165, 4513.255312873404, 4548.795304211319, 4602.194615942197, 4608.101420223092, 4617.722936623813, 4919.483454237254, 4982.77577509013, 5018.5985121190215, 5026.195808670595, 5091.032703786269, 4826.903461930812, 4836.854894353175, 4844.733539655353, 4848.660593758474, 4896.779644915988, 4764.857054288377, 4914.483979182206, 4915.65590408668, 4928.408590969035, 4977.751112444364, 4738.691985020962, 4855.660103792771, 4900.754962251873, 4921.557059864629, 4980.601551875841, 4881.170201065756, 4885.682430641997, 4899.289603007615, 4902.058169103618, 4963.106640804617, 4075.0831063010587, 4082.081531655354, 4088.836446542105, 4099.262132816122, 4142.399352093929, 3580.3555360035443, 3605.729570282187, 3616.7106631469946, 3661.798601076913, 3699.260147970363, 4278.443802305743, 4283.357496375568, 4286.635635970977, 4328.480582330078, 4336.3278691802825, 4952.876178095505, 4961.355023846877, 4966.553010229097, 4969.627277954096, 5022.221555658805, 4235.724677895927, 4252.723572967747, 4267.957320426818, 4279.2083464559155, 4279.700420970502, 4433.733975961452, 4455.5989960903025, 4500.414946057057, 4508.1659892919915, 4511.954880451219, 4676.298555216745, 4683.976580117078, 4687.10944920464, 4692.671512994058, 4743.980044290494, 4887.706737595756, 4909.7545122743, 4934.777934992862, 4946.307516947558, 4978.253262010582, 4686.976565117153, 4710.081534100817, 4712.340272361941, 4750.453697824794, 4768.475467698481, 4899.240617704261, 4901.338319326987, 4906.8773280668265, 4922.606191504743, 4964.602831773522, 4863.440704319049, 4899.951000489949, 4909.729964851967, 4995.075910956485, 5057.266696329085, 4788.018456216537, 4825.4933232010135, 4829.323894654822, 4863.586595139312, 4922.458529561817, 4848.781804818721, 4861.51384861511, 4862.124817532878, 4863.2461968394955, 4926.753662316942, 4799.736014519095, 4807.78364973584, 4814.325994360723, 4814.5907597854575, 4857.878553036202, 4723.858284251478, 4815.253635686474, 4833.03339332128, 4833.492483289345, 4909.042736666316, 4722.409698787652, 4735.526447355237, 4743.407074115736, 4744.881377965578, 4795.808167673394], "value": 4536.254238205325, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.9948889188366, 585.1486087742334, 585.5403508246022, 589.2045738253358, 597.3339726205282, 27378.0, 36840.0, 37813.62186378139, 38022.61977380225, 41377.17245655085, 32947.83526082366, 33221.33557328858, 33231.50152747705, 33233.33533329332, 33254.8337258314, 7405.111386633612, 7574.35617972473, 7580.431467639949, 7583.696652133908, 7591.051118610174, 7510.8122296942465, 7566.924330756677, 7568.205338439439, 7595.7721268361765, 7599.506032107923, 7573.356264717506, 7586.886196707026, 7601.8479630407355, 7625.466217364787, 7634.312911837934, 7567.129780075306, 7607.65765540552, 7610.200928902441, 7613.923860761377, 7614.581198034106, 7204.3155900189395, 7263.201047884729, 7263.745768898116, 7266.091738532684, 7269.63651817407, 36178.63821361779, 36509.63490365089, 36539.08652283688, 36555.81722091399, 36585.81707091474, 2700.932476688079, 2755.4489102179646, 2772.37621535153, 2948.557716342544, 3048.7713421493477, 25230.495390092095, 25563.74436255632, 25644.35889102769, 26132.216033519024, 26461.867690661617, 3307.1897385140555, 3339.34882697874, 3362.8318584070944, 3369.3598216339064, 3382.272811345548, 243556.0, 245213.0, 245483.0, 246078.0, 246352.76823615946, 30683.2329191772, 31354.68645313518, 31563.684363156535, 32627.34745305128, 43338.0, 28425.28936776597, 28436.289092772848, 28501.857490712413, 28507.57238641422, 28509.857450712614, 11827.0, 11892.405379730979, 11905.940470297593, 11954.76090478203, 11973.820392694117, 9559.90440095604, 9602.32783705148, 9629.470379129216, 9727.902720972841, 9739.415635061778, 7601.429892758065, 7659.731909383145, 7719.150893401721, 7753.10839253493, 7754.534727916343, 2941.8529073546238, 2982.507886198753, 2986.357933044406, 2997.955030674542, 3054.1906394805396, 811.4482152136604, 899.8290324838259, 910.9797027329301, 933.1927882381826, 977.94621295828, 26248.86875565648, 26956.59565106525, 27293.626952009574, 27447.588286175724, 27644.72355276462, 786.1588100732276, 931.0782325497844, 934.2105920497169, 960.1071003966239, 984.4487087231173, 13335.333233338295, 14143.151410915378, 14246.643833904236, 14287.64280892986, 14404.711905761826, 372907.0, 375997.0, 376846.0, 378652.0, 379065.0, 46315.536844631126, 46798.0, 46836.7658161707, 46921.29618055732, 46923.29615055777, 1063.2716589136467, 1126.436781609179, 1134.7560274541013, 1153.861536615578, 1154.6432941294113, 26277.211683649522, 27616.309592260353, 28155.0, 28358.43283134367, 28688.569671455363, 38978.80510597429, 39523.60476395199, 39627.60372396239, 39646.0, 39655.80172099121, 286408.0, 286997.0, 287461.0, 288054.0, 288723.0, 24231.75768242295, 25334.493310133326, 25366.1121860734, 26099.217023489327, 26165.345866353495, 38789.0, 39321.41017884791, 39507.0, 39866.80066599648, 40483.59516404798, 33873.0, 34001.48997765085, 34026.0, 34150.0, 34231.486527702604, 34067.82966085154, 34149.31701366008, 34291.0, 34515.82742086273, 34951.82524087363, 33905.32189356248, 34267.4859877107, 34485.82757086299, 34722.13194670052, 35101.297974039866, 30052.69947300499, 31077.533836992916, 31392.0, 31489.21276968094, 31749.682503174674, 23950.88024559866, 23953.52092958166, 24077.890839043037, 24629.261122166365, 24631.38421539476], "value": 15417.902408102433, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.6792411360982, 357.54413123267847, 364.75379119094606, 366.46130188622715, 378.45124569374394, 12688.936555317223, 13587.094399315529, 13823.308834558282, 16923.57691057724, 16956.74564881528, 14865.554033378989, 15232.390704371812, 15512.0, 15553.455629052985, 16087.115208663548, 4330.675199360045, 4455.0, 4459.397981272536, 4463.062756821071, 4467.955320446803, 3425.8972230833115, 5119.846404607868, 5281.551068159211, 5365.597580181482, 5401.756920938567, 5388.622796404254, 5396.19057141428, 5398.838034858941, 5399.568034557226, 5401.297831281928, 4760.880977975544, 4979.327790748257, 5003.149464591028, 5045.369328833895, 5050.368703912011, 4842.595647262289, 4905.411350637911, 4914.287428322909, 4914.533119353656, 4915.803367865281, 11450.828237576443, 11803.11476639247, 11811.114166437552, 11819.172657913949, 11823.94088029563, 1804.1971322761376, 1889.5748456597294, 1901.3937593753465, 1915.9137838797287, 1979.5348093198088, 8553.486790792573, 8740.388172827905, 8913.328874687262, 9205.355625106245, 9345.0, 1730.4203091964207, 1744.4069016534313, 1755.1750677181703, 1764.876458647895, 1770.1060964213118, 65844.3415565843, 66372.0, 71562.64218678873, 71888.6405567974, 71948.28051719468, 9747.658831940847, 9797.15882394112, 9995.200383969264, 10048.14590759779, 10211.336263143021, 13653.590392288248, 13708.3831227595, 13710.588682339545, 13730.862691373159, 13747.725045499034, 6441.67791610427, 6479.870402591921, 6529.3470652935275, 6614.66926653675, 6674.899876501856, 5943.940560594425, 6093.512518998469, 6127.203463549799, 6169.5064394848305, 6197.287311959182, 4232.915341693149, 4277.508086570084, 4303.397524346594, 4324.551275322802, 4406.537313582092, 1537.569480545449, 1675.7570152327844, 1746.9126543672764, 1772.459399883048, 1775.5028591994262, 695.4957655699577, 765.9157492675802, 801.3148757812103, 817.9631916563769, 879.8944126704837, 16752.1623918806, 16768.6646267074, 16915.968438944, 16967.49097527076, 17356.3057477702, 841.8316336732678, 866.2160744526213, 897.9955100224457, 929.0198840223494, 933.3886304470583, 9279.536023198812, 9909.65316213929, 9938.155256803107, 9943.602255909827, 9969.700908972598, 393196.0, 394408.0, 396482.0, 403546.0, 407186.0, 73071.63464182644, 74783.0, 75299.0, 77273.0, 78045.0, 790.4150928313007, 891.6166048599165, 893.9865902011475, 910.9180173784391, 918.2883265469314, 14065.718685626434, 14995.250237487864, 15141.242937853283, 15739.89820712539, 15741.212939352758, 34171.65828341685, 34757.47863782096, 35571.822140890166, 36272.0, 38468.23063538769, 49694.0, 50467.242991354426, 50566.2415063767, 51717.482825172774, 51719.74140129426, 7291.817704557428, 7368.37368823656, 7561.962190189014, 7622.54264744095, 7679.884801727867, 10915.454227288445, 11291.209615326849, 11585.594504192313, 11864.762704745684, 12093.697657558632, 9959.601615935282, 10211.438370889673, 10359.792804143724, 10530.947345263225, 10964.56141754321, 9835.508224588599, 10083.193344532274, 10310.381377117397, 10391.896081039093, 10645.574177032831, 10202.642907498202, 10213.33613315132, 10415.0, 10688.0, 11063.612773552886, 7294.890576641248, 7434.888476672746, 7476.177620461854, 7512.5492470451945, 7684.462087654034, 8367.07557261821, 9876.35803672759, 10328.845067323846, 10336.795593366081, 10348.482575871327], "value": 7819.742254155106, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1330.2417621955483, 1374.2098293481247, 1390.5202705066754, 1569.7959265295524, 1606.6545692676073, 6628.469722422206, 6856.554323968951, 7078.504504684674, 7629.618519074045, 7633.73281935133, 7349.522281051728, 7585.658645360958, 7606.163322034586, 7608.771736847903, 7618.9619051904665, 2113.154738104759, 2145.8497905146646, 2148.3662319615673, 2150.666646669769, 2157.007776422847, 1781.7238328059107, 2105.8315334773256, 2111.6410210264294, 2113.165299706615, 2125.7130287411155, 2034.1964923855069, 2095.025812996956, 2097.0982477534653, 2104.6527322991687, 2105.105330234652, 2086.447091520748, 2109.040386624082, 2109.831213502916, 2112.42964399612, 2131.5736852629534, 2087.9478013049643, 2131.467133216696, 2132.1471411435396, 2133.551954089643, 2137.5724855029057, 7594.278543538355, 7657.770266892002, 7663.808404789925, 7670.156282808943, 7678.424118191158, 4198.32826747722, 4319.352097185416, 4324.178406102862, 4325.243082460557, 4329.177456283296, 2743.341598016482, 2919.3285544324713, 2924.5613158026254, 2931.8094323869095, 2932.7213914678073, 838.5932822581043, 879.041844389612, 883.4478450968145, 885.9512726800024, 903.0472851142042, 10400.323978941344, 10410.635627753069, 10411.958804119604, 10417.739556511073, 10450.320729152581, 3738.495303134042, 3966.960330396659, 4041.8787436376956, 4065.5324637667045, 4098.6516146127915, 8915.063918288486, 8922.241609463139, 8923.553822308859, 8929.464232146092, 8934.329925255632, 4356.760378179167, 4357.2592659248, 4359.869203923888, 4364.62900653448, 4365.126974605092, 3872.593377695358, 3923.803809809498, 3927.4108883667677, 3936.3701807710627, 3937.842486300573, 3423.0, 3471.9826400867832, 3521.207728261172, 3523.224890524081, 3538.5576802899636, 1049.0715716590719, 1144.6966553863233, 1150.8734039255676, 1161.512164890748, 1175.9000484958874, 655.8032590222914, 664.6278084272823, 665.3346653346654, 698.7938558125365, 765.7817522006313, 5005.299258103868, 5013.122703526941, 5047.242913562922, 5103.668261562986, 5214.8957020860125, 797.1908512859452, 807.7899746065948, 817.5013241922422, 817.8854960305562, 856.5845564901018, 3358.748093892968, 3571.1250743567994, 3687.8893633191046, 3711.0722319420147, 3725.2177042821313, 9222.123898229658, 9643.614255429704, 9643.903560964442, 9644.517774111408, 9670.323077384515, 9539.52302384878, 9558.330916835894, 9559.713208603753, 9561.330706850593, 9565.952170239105, 7196.424286057103, 7213.278672132745, 7230.313120253462, 7356.337929586363, 7368.078990126234, 4961.156603377507, 5073.16292811682, 5188.636795424435, 5368.141097424394, 5522.22688823573, 8545.477044920182, 8599.312055035707, 8635.6977505787, 8638.697645582375, 8661.740147795575, 8601.784955375915, 8704.129587041245, 8957.552122393723, 8978.775530611787, 8989.685361012333, 6386.904196436964, 6606.4384527315715, 6607.900881486878, 6612.768553100618, 6638.966805165944, 7017.333353331425, 7080.114985626797, 7128.536645118051, 7132.215456299699, 7136.571805691675, 6514.088027676224, 6552.246491653521, 6589.0, 6662.133922590227, 6678.899816502659, 6295.5907865988565, 6402.263739669811, 6449.806505804833, 6556.5738227017, 6574.967125164535, 5891.263592050994, 5965.791197308074, 6007.669578173068, 6066.969665151646, 6071.150038994632, 4573.794179262008, 4618.30725391194, 4656.976715116402, 4728.858134255978, 4878.024395121061, 4460.330950357472, 4539.137563862855, 4547.272436410159, 4642.837500687459, 4732.763361831826], "value": 4001.5528493944316, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.3494033603384, 290.4887398179204, 292.7731008468438, 296.20173632061596, 298.9805662631929, 4804.927926081112, 4856.44150922644, 4871.930683669283, 4886.389201349832, 4897.485763994782, 4743.857684269469, 4770.09368220038, 4835.226363781796, 4838.467768545457, 4840.443349014864, 3591.8204089795536, 3695.907602309937, 3704.0369503928905, 3744.588095309514, 3776.9055773605605, 3759.135398858264, 3769.754965927206, 3780.962190378102, 3787.704696913689, 3794.4118661607495, 3731.4589384539227, 3748.7938163401004, 3763.1344790698154, 3769.6230376962358, 3775.603561626031, 3566.892993210208, 3591.6947059499976, 3705.962940370589, 3722.324953770787, 3748.306563285801, 3297.950530742041, 3300.834958252102, 3307.4212012897888, 3308.2060305526743, 3309.8841540546205, 4592.2193227151465, 4629.3750343703505, 4637.0, 4657.92722238604, 4680.461746899082, 4196.328587426027, 4254.978725106354, 4261.4673165854265, 4296.205202037601, 4312.2022425851, 4944.431390390079, 4958.355413796184, 4982.277569752402, 4984.2025275955675, 4985.152524070881, 3597.6222496638, 3599.5860476045327, 3603.4865356550313, 3611.855525778966, 3614.2410093880317, 4947.381577302837, 5278.498542638443, 5284.788608455658, 5285.339332583427, 5296.761645725952, 3541.7166626669805, 3571.2857428514403, 3574.4638304254568, 3601.5689409648385, 3608.8376023079027, 3624.9637503625154, 3629.0745859806107, 3629.909252268714, 3642.7450078494253, 3643.908902277464, 4190.245755763992, 4193.308104162779, 4196.265653510623, 4203.91592168155, 4205.243056249905, 4879.682820616648, 5016.423111342169, 5034.194528875362, 5053.545180933734, 5057.949420505748, 1267.4930027988878, 1283.3903895649491, 1285.7042880137433, 1286.1961274203622, 1289.6517940156104, 809.7368355284556, 812.8455593437346, 814.5031530766228, 816.5182542300072, 858.965641374338, 4376.124775045004, 4394.12117576486, 4404.647628189737, 4405.31717583775, 4430.224710675619, 5088.414832294259, 5094.261332106824, 5100.872478188001, 5103.693778373309, 5113.207452844815, 4282.785860707015, 4386.758728269912, 4390.846320378771, 4413.646908247332, 4419.315006174048, 2701.18964310706, 2705.201965420206, 2705.6482657254433, 2711.7492481240524, 2714.9864250679016, 4783.091212669582, 4798.328234047236, 4815.7351345676325, 4818.494058123846, 4828.348172996671, 5076.238564215398, 5129.724844048627, 5224.843254702365, 5227.529522343008, 5229.450907654642, 4749.430068391746, 4757.500462451531, 4787.736674482937, 4815.3499277597775, 4833.685810422311, 5051.469595692546, 5062.645614806928, 5067.771950262173, 5127.743702792691, 5133.974330128325, 4805.9038819224115, 5009.17165234694, 5010.396673064584, 5020.598352131894, 5020.799168033238, 4755.1916174251155, 4777.355057067251, 4812.205986012409, 4821.590164836029, 4840.564349208588, 3612.060864175386, 3625.4018087015347, 3629.909252268714, 3647.598764135996, 3655.2506736119562, 4832.347633069631, 5046.233818163761, 5072.391313042459, 5148.639595228298, 5164.225366194951, 4881.31661567388, 4925.975370123127, 4929.827456039022, 4947.802087916443, 4951.356323677899, 4915.680480768739, 4954.0, 4954.479779623088, 4957.157283261926, 4966.553010229097, 4675.929861052155, 4792.712437253636, 4840.419149701917, 4850.902981940412, 4861.708297502161, 4810.663253572357, 4939.75301234944, 5009.0, 5046.568333533232, 5055.292259083805, 4879.853604391874, 4949.480304567968, 4955.331030310862, 4956.256561515802, 4966.1941003333], "value": 3752.997194728813, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.7387549478229, 599.2988203801552, 612.7548980407836, 621.2793159934477, 626.1265534579262, 11712.648620541388, 12151.817722734166, 12803.679908002305, 12809.0, 12825.551105711302, 12712.872871271307, 12884.871151288484, 12923.806142907864, 12968.027397945145, 12969.93515032426, 624.0763669768745, 746.1754760989097, 767.45510687412, 772.8570214510333, 772.9574873381962, 744.7021191523407, 754.811297175706, 761.2045412543878, 777.2810150610691, 778.1829079466537, 813.4631143445328, 818.3616778912428, 820.5692011693878, 820.7250571058703, 820.9466384684977, 649.9675016249168, 811.9878201826978, 812.1513018895268, 812.6546217857416, 812.8008637883727, 566.3317285602986, 570.8344580071774, 575.5309422820429, 588.5703436491342, 588.6203398807745, 11764.764704705944, 11830.763384732343, 11881.821772673416, 11915.285082895054, 11930.821037684442, 11304.547818087267, 11754.588589399416, 11768.0, 11850.88149118515, 12733.87266127336, 9009.414388064755, 9063.41087829289, 9065.0, 9190.35667503275, 9332.533373331305, 3989.1024519483176, 4044.534878488982, 4071.97964010181, 4073.674106071507, 4100.876973690794, 64218.67890660517, 64297.35702642961, 64308.67845660742, 64314.3568564313, 64401.08579912684, 9383.155516003593, 9539.18916892058, 9884.209263258923, 9951.651692190739, 10212.285140040125, 19039.428817135507, 19155.90422047881, 19165.425037248904, 19186.328478503186, 19246.518837028907, 6538.705758240891, 6575.473962083118, 6608.2730899601, 6653.500987425962, 6748.0, 3591.317649646559, 3592.820358982093, 3610.0, 3650.817459127033, 3658.981705091511, 2607.4654695787317, 2684.1410748560274, 2690.2736261209366, 2693.0843513205605, 2703.405250844811, 486.8028448478301, 487.3104557051803, 495.7124867576797, 498.64097849548267, 505.69152816781735, 472.1030042918482, 477.6632474105747, 487.73174753885223, 491.6582974832457, 518.2873548870303, 7166.319199676022, 7363.9631801841715, 7376.906166032766, 7675.347595454449, 7762.417818663623, 408.5179488203888, 418.98533551325556, 429.7013575565015, 430.15474592426034, 446.2703479810468, 3542.71658267338, 3558.430651095812, 3635.8545658173375, 3711.0, 3715.5727091384297, 98528.50735746419, 100246.49876750716, 101452.49273753584, 102996.48501757444, 103303.4834825821, 86359.56820215858, 89630.75923101975, 89929.55035224782, 90220.0, 92527.0, 58602.70698646479, 75455.68589035599, 75991.0, 76978.6151069241, 79281.0, 6748.325167483409, 6835.658217089225, 6957.095577574883, 7037.366637002694, 7252.2747725227055, 46951.29573056338, 47594.0, 47699.5230047709, 48416.27375589439, 48879.511204887494, 37323.0, 52927.0, 55566.44433555612, 56057.43942560522, 60684.6965765186, 10593.0, 10740.570377185139, 10978.505967231335, 11161.720956975816, 11528.423578821194, 12417.254964702146, 12494.812577811159, 12543.372831358578, 12662.240265584094, 12724.618261452171, 11457.656270311903, 11466.0, 11966.880331196577, 12020.459079341626, 12047.75904481923, 11481.425928703698, 11550.249233799776, 11627.418629068343, 12020.519179233082, 12476.937615312228, 10091.243156763125, 10737.302075365076, 10970.561177553127, 11076.280041797258, 11152.0, 9717.611295548098, 9771.31600787938, 9774.951125244328, 9956.800863982824, 10104.141148002209, 8496.660133594587, 8960.775980600538, 9329.813403732023, 9492.335536512654, 9624.37441566296], "value": 6274.048022528561, "unit": "score"}], "name": "dromaeo_css", "value": 6100.3195327867315, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 127.0, 114.0, 112.0, 115.0, 114.0, 117.0, 116.0, 114.0], "value": 115.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 125.0, 148.0, 188.0, 123.0, 146.0, 145.0, 124.0, 187.0, 127.0], "value": 146.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 162.0, 161.0, 161.0, 161.0, 162.0, 160.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 166.0, 78.0, 76.0, 75.0, 75.0, 171.0, 75.0], "value": 94.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 146.0, 87.0, 88.0, 87.0, 145.0, 86.0, 85.0, 142.0], "value": 103.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 145.0, 148.0, 146.0, 145.0, 147.0, 148.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 67.0, 70.0, 66.0, 66.0, 66.0, 66.0, 65.0, 66.0], "value": 66.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 65.0, 67.0, 66.0, 65.0, 66.0, 66.0, 67.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 84.0, 84.0, 86.0, 89.0, 83.0, 84.0, 85.0, 83.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 131.0, 147.0, 131.0, 131.0, 132.0, 145.0, 133.0, 151.0, 136.0], "value": 138.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 174.0, 177.0, 172.0, 174.0, 178.0, 178.0, 173.0, 179.0, 176.0], "value": 175.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 71.0, 69.0, 68.0, 69.0, 69.0, 69.0, 67.0, 69.0], "value": 68.8, "unit": "score"}], "name": "kraken", "value": 1579.3999999999999, "alertThreshold": 2.0}]} 15:32:57 INFO - Return code: 0 15:32:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:32:57 INFO - # TBPL SUCCESS # 15:32:57 INFO - Running post-action listener: _resource_record_post_action 15:32:57 INFO - [mozharness: 2016-08-23 22:32:57.649706Z] Finished run-tests step (success) 15:32:57 INFO - Running post-run listener: _resource_record_post_run 15:32:57 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 420683776; Read time: 8; Write time: 368408 15:32:57 INFO - TinderboxPrint: CPU usage
13.3% 15:32:57 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 15:32:57 INFO - TinderboxPrint: I/O write bytes / time
420,683,776 / 368,408 15:32:57 INFO - TinderboxPrint: CPU idle
8,332.0 (86.7%) 15:32:57 INFO - TinderboxPrint: CPU user
1,207.8 (12.6%) 15:32:57 INFO - TinderboxPrint: Swap in / out
0 / 0 15:32:57 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 130146304; Read time: 0; Write time: 122652 15:32:57 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 289587200; Read time: 0; Write time: 245728 15:32:58 INFO - Running post-run listener: _upload_blobber_files 15:32:58 INFO - Blob upload gear active. 15:32:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:32:58 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:32:58 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'] 15:32:58 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 15:32:58 INFO - (blobuploader) - INFO - Open directory for files ... 15:32:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:32:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:32:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:33:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:33:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:33:02 INFO - (blobuploader) - INFO - Done attempting. 15:33:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:33:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:33:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:33:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:33:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:33:02 INFO - (blobuploader) - INFO - Done attempting. 15:33:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:33:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:33:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:33:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:33:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:33:03 INFO - (blobuploader) - INFO - Done attempting. 15:33:03 INFO - (blobuploader) - INFO - Iteration through files over. 15:33:03 INFO - Return code: 0 15:33:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:33:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:33:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/390252d2c57a21272416eea32a5a04e6e92e635c9815041e21b0f44054a04ab819c0169a6130d13c3ea7e7dd641738853f2fa84ab6408fccb02afac8efb5d08d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1d8e205bd162934d79adba9648cb77012872a3dd320b2dc90ab5206adb1e0eb3dad253b243a535b38ec77e2a027764fff85e38cef3b9d44add2f59937d18c516", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/60a3bcce35710ca8e1389d2b04d13049058d7d80eb0cdc69a3a9470d034fba9272a376be0be242ba22ce4709b4484af30f9c5132cd69807523ad184ad6a2e52d"} 15:33:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:33:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:33:03 INFO - Contents: 15:33:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/390252d2c57a21272416eea32a5a04e6e92e635c9815041e21b0f44054a04ab819c0169a6130d13c3ea7e7dd641738853f2fa84ab6408fccb02afac8efb5d08d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1d8e205bd162934d79adba9648cb77012872a3dd320b2dc90ab5206adb1e0eb3dad253b243a535b38ec77e2a027764fff85e38cef3b9d44add2f59937d18c516", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/60a3bcce35710ca8e1389d2b04d13049058d7d80eb0cdc69a3a9470d034fba9272a376be0be242ba22ce4709b4484af30f9c5132cd69807523ad184ad6a2e52d"} 15:33:03 INFO - Running post-run listener: copy_logs_to_upload_dir 15:33:03 INFO - Copying logs to upload dir... 15:33:03 INFO - mkdir: /builds/slave/test/build/upload/logs 15:33:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.576225 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-08-23 15:33:03.542642) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-23 15:33:03.548564) ========= 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=af724c981e2a0f424dbabf99000001e7-1471990334.421674-1947986402 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/390252d2c57a21272416eea32a5a04e6e92e635c9815041e21b0f44054a04ab819c0169a6130d13c3ea7e7dd641738853f2fa84ab6408fccb02afac8efb5d08d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1d8e205bd162934d79adba9648cb77012872a3dd320b2dc90ab5206adb1e0eb3dad253b243a535b38ec77e2a027764fff85e38cef3b9d44add2f59937d18c516", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/60a3bcce35710ca8e1389d2b04d13049058d7d80eb0cdc69a3a9470d034fba9272a376be0be242ba22ce4709b4484af30f9c5132cd69807523ad184ad6a2e52d"} build_url:https://queue.taskcluster.net/v1/task/Darib8q4Q76VZa-jXt8x9w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011218 build_url: 'https://queue.taskcluster.net/v1/task/Darib8q4Q76VZa-jXt8x9w/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/390252d2c57a21272416eea32a5a04e6e92e635c9815041e21b0f44054a04ab819c0169a6130d13c3ea7e7dd641738853f2fa84ab6408fccb02afac8efb5d08d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1d8e205bd162934d79adba9648cb77012872a3dd320b2dc90ab5206adb1e0eb3dad253b243a535b38ec77e2a027764fff85e38cef3b9d44add2f59937d18c516", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/60a3bcce35710ca8e1389d2b04d13049058d7d80eb0cdc69a3a9470d034fba9272a376be0be242ba22ce4709b4484af30f9c5132cd69807523ad184ad6a2e52d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-23 15:33:03.574309) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 15:33:03.574654) ========= 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=af724c981e2a0f424dbabf99000001e7-1471990334.421674-1947986402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004450 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 15:33:03.660273) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-23 15:33:03.660627) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-23 15:33:03.660989) ========= ========= Total master_lag: 0.17 =========