builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-022 starttime: 1470421433.59 results: success (0) buildid: 20160805083002 builduid: 304a0176f1624ea2a0394db3d9d79283 revision: bfb4f7467dd4b39005d61fbcb2872da14a29d66b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 11:23:53.586393) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 11:23:53.586920) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-05 11:23:53.587303) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-05 11:23:53.603748) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 11:23:53.604273) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1470421432.836438-1338878370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-05 11:23:53-- 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% 42.7M=0s 2016-08-05 11:23:53 (42.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.092055 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 11:23:53.711468) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 11:23:53.711804) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1470421432.836438-1338878370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019889 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 11:23:53.761442) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 11:23:53.761813) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev bfb4f7467dd4b39005d61fbcb2872da14a29d66b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev bfb4f7467dd4b39005d61fbcb2872da14a29d66b --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=9c43b49b387003dc8f5b4e5c000001c4-1470421432.836438-1338878370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-05 11:23:53,822 truncating revision to first 12 chars 2016-08-05 11:23:53,822 Setting DEBUG logging. 2016-08-05 11:23:53,822 attempt 1/10 2016-08-05 11:23:53,822 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/bfb4f7467dd4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-05 11:23:54,145 unpacking tar archive at: fx-team-bfb4f7467dd4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.637698 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 11:23:54.414070) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 11:23:54.414503) ========= script_repo_revision: bfb4f7467dd4b39005d61fbcb2872da14a29d66b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 11:23:54.414923) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 11:23:54.415200) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 11:23:54.426131) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-08-05 11:23:54.426567) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1470421432.836438-1338878370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:23:54 INFO - MultiFileLogger online at 20160805 11:23:54 in /builds/slave/test 11:23:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:23:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:23:54 INFO - {'append_to_log': False, 11:23:54 INFO - 'base_work_dir': '/builds/slave/test', 11:23:54 INFO - 'blob_upload_branch': 'Fx-Team', 11:23:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:23:54 INFO - 'branch': 'Fx-Team', 11:23:54 INFO - 'buildbot_json_path': 'buildprops.json', 11:23:54 INFO - 'config_files': ('talos/linux_config.py',), 11:23:54 INFO - 'default_actions': ('clobber', 11:23:54 INFO - 'read-buildbot-config', 11:23:54 INFO - 'download-and-extract', 11:23:54 INFO - 'populate-webroot', 11:23:54 INFO - 'create-virtualenv', 11:23:54 INFO - 'install', 11:23:54 INFO - 'run-tests'), 11:23:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:23:54 INFO - 'download_minidump_stackwalk': True, 11:23:54 INFO - 'download_symbols': 'ondemand', 11:23:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:23:54 INFO - 'tooltool.py': '/tools/tooltool.py', 11:23:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:23:54 INFO - '/tools/misc-python/virtualenv.py')}, 11:23:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:23:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:23:54 INFO - 'installer_path': 'installer.exe', 11:23:54 INFO - 'log_level': 'info', 11:23:54 INFO - 'log_name': 'talos', 11:23:54 INFO - 'log_to_console': True, 11:23:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:23:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:23:54 INFO - 'opt_config_files': (), 11:23:54 INFO - 'pip_index': False, 11:23:54 INFO - 'sps_profile': False, 11:23:54 INFO - 'sps_profile_interval': 0, 11:23:54 INFO - 'suite': 'dromaeojs', 11:23:54 INFO - 'system_bits': '32', 11:23:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:23:54 INFO - 'title': 'talos-linux64-ix-022', 11:23:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:23:54 INFO - 'use_talos_json': True, 11:23:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:23:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:23:54 INFO - 'work_dir': 'build'} 11:23:54 INFO - [mozharness: 2016-08-05 18:23:54.581086Z] Running clobber step. 11:23:54 INFO - Running pre-action listener: _resource_record_pre_action 11:23:54 INFO - Running main action method: clobber 11:23:54 INFO - rmtree: /builds/slave/test/build 11:23:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:23:55 INFO - Running post-action listener: _resource_record_post_action 11:23:55 INFO - [mozharness: 2016-08-05 18:23:55.079193Z] Finished clobber step (success) 11:23:55 INFO - [mozharness: 2016-08-05 18:23:55.079292Z] Running read-buildbot-config step. 11:23:55 INFO - Running pre-action listener: _resource_record_pre_action 11:23:55 INFO - Running main action method: read_buildbot_config 11:23:55 INFO - Using buildbot properties: 11:23:55 INFO - { 11:23:55 INFO - "project": "", 11:23:55 INFO - "product": "firefox", 11:23:55 INFO - "script_repo_revision": "production", 11:23:55 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:23:55 INFO - "repository": "", 11:23:55 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:23:55 INFO - "buildid": "20160805083002", 11:23:55 INFO - "pgo_build": "True", 11:23:55 INFO - "basedir": "/builds/slave/test", 11:23:55 INFO - "buildnumber": 1426, 11:23:55 INFO - "slavename": "talos-linux64-ix-022", 11:23:55 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:23:55 INFO - "platform": "ubuntu64_hw", 11:23:55 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:23:55 INFO - "branch": "fx-team", 11:23:55 INFO - "repo_path": "integration/fx-team", 11:23:55 INFO - "revision": "bfb4f7467dd4b39005d61fbcb2872da14a29d66b", 11:23:55 INFO - "stage_platform": "linux64-pgo", 11:23:55 INFO - "builduid": "304a0176f1624ea2a0394db3d9d79283", 11:23:55 INFO - "slavebuilddir": "test" 11:23:55 INFO - } 11:23:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/H3M2V4CaRMm8vgmUv0o7Hw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 11:23:55 INFO - Running post-action listener: _resource_record_post_action 11:23:55 INFO - [mozharness: 2016-08-05 18:23:55.081721Z] Finished read-buildbot-config step (success) 11:23:55 INFO - [mozharness: 2016-08-05 18:23:55.081809Z] Running download-and-extract step. 11:23:55 INFO - Running pre-action listener: _resource_record_pre_action 11:23:55 INFO - Running main action method: download_and_extract 11:23:55 INFO - mkdir: /builds/slave/test/build/tests 11:23:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:55 INFO - trying https://queue.taskcluster.net/v1/task/H3M2V4CaRMm8vgmUv0o7Hw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:23:55 INFO - Downloading https://queue.taskcluster.net/v1/task/H3M2V4CaRMm8vgmUv0o7Hw/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 11:23:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H3M2V4CaRMm8vgmUv0o7Hw/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 11:23:55 INFO - Downloaded 1361 bytes. 11:23:55 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:23:55 INFO - Using the following test package requirements: 11:23:55 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:23:55 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:23:55 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:23:55 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:23:55 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:23:55 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:23:55 INFO - u'jsshell-linux-x86_64.zip'], 11:23:55 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:23:55 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:23:55 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:23:55 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:23:55 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:23:55 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:23:55 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:23:55 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:23:55 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:23:55 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:23:55 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:23:55 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:23:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:55 INFO - trying https://queue.taskcluster.net/v1/task/H3M2V4CaRMm8vgmUv0o7Hw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:23:55 INFO - Downloading https://queue.taskcluster.net/v1/task/H3M2V4CaRMm8vgmUv0o7Hw/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 11:23:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H3M2V4CaRMm8vgmUv0o7Hw/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 11:23:56 INFO - Downloaded 21825714 bytes. 11:23:56 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 11:24:00 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 11:24:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:00 INFO - trying https://queue.taskcluster.net/v1/task/H3M2V4CaRMm8vgmUv0o7Hw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:24:00 INFO - Downloading https://queue.taskcluster.net/v1/task/H3M2V4CaRMm8vgmUv0o7Hw/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 11:24:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H3M2V4CaRMm8vgmUv0o7Hw/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 11:24:01 INFO - Downloaded 21825714 bytes. 11:24:01 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 11:24:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:06 INFO - trying https://queue.taskcluster.net/v1/task/H3M2V4CaRMm8vgmUv0o7Hw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 11:24:06 INFO - Downloading https://queue.taskcluster.net/v1/task/H3M2V4CaRMm8vgmUv0o7Hw/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 11:24:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H3M2V4CaRMm8vgmUv0o7Hw/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 11:24:07 INFO - Downloaded 14413723 bytes. 11:24:07 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 11:24:07 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')]} 11:24:07 INFO - trying https://queue.taskcluster.net/v1/task/H3M2V4CaRMm8vgmUv0o7Hw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:24:07 INFO - Downloading https://queue.taskcluster.net/v1/task/H3M2V4CaRMm8vgmUv0o7Hw/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 11:24:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H3M2V4CaRMm8vgmUv0o7Hw/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 11:24:08 INFO - Downloaded 59982015 bytes. 11:24:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H3M2V4CaRMm8vgmUv0o7Hw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:24:08 INFO - mkdir: /builds/slave/test/properties 11:24:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:24:08 INFO - Writing to file /builds/slave/test/properties/build_url 11:24:08 INFO - Contents: 11:24:08 INFO - build_url:https://queue.taskcluster.net/v1/task/H3M2V4CaRMm8vgmUv0o7Hw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:24:09 INFO - Running post-action listener: _resource_record_post_action 11:24:09 INFO - Running post-action listener: set_extra_try_arguments 11:24:09 INFO - [mozharness: 2016-08-05 18:24:09.321791Z] Finished download-and-extract step (success) 11:24:09 INFO - [mozharness: 2016-08-05 18:24:09.322015Z] Running populate-webroot step. 11:24:09 INFO - Running pre-action listener: _resource_record_pre_action 11:24:09 INFO - Running main action method: populate_webroot 11:24:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:24:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:24:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:24:09 INFO - '--tppagecycles', 11:24:09 INFO - '7'], 11:24:09 INFO - 'tests': ['tsvgm']}}, 11:24:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:24:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:24:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:24:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:24:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:24:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:24:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:09 INFO - 'talos_options': ['--disable-e10s'], 11:24:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:24:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:24:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:09 INFO - 'talos_options': ['--disable-e10s'], 11:24:09 INFO - 'tests': ['damp', 'tps']}, 11:24:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:09 INFO - 'tests': ['damp', 'tps']}, 11:24:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:24:09 INFO - 'tests': ['dromaeo_dom']}, 11:24:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:24:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:24:09 INFO - 'tests': ['basic_compositor_video']}, 11:24:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:24:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:24:09 INFO - 'tests': ['a11yr', 11:24:09 INFO - 'ts_paint', 11:24:09 INFO - 'tpaint', 11:24:09 INFO - 'sessionrestore', 11:24:09 INFO - 'sessionrestore_no_auto_restore', 11:24:09 INFO - 'tabpaint']}, 11:24:09 INFO - 'other-e10s': {'tests': ['a11yr', 11:24:09 INFO - 'ts_paint', 11:24:09 INFO - 'tpaint', 11:24:09 INFO - 'sessionrestore', 11:24:09 INFO - 'sessionrestore_no_auto_restore', 11:24:09 INFO - 'tabpaint']}, 11:24:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:24:09 INFO - 'ts_paint', 11:24:09 INFO - 'tpaint', 11:24:09 INFO - 'sessionrestore', 11:24:09 INFO - 'sessionrestore_no_auto_restore', 11:24:09 INFO - 'tabpaint']}, 11:24:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:24:09 INFO - 'ts_paint', 11:24:09 INFO - 'tpaint', 11:24:09 INFO - 'sessionrestore', 11:24:09 INFO - 'sessionrestore_no_auto_restore', 11:24:09 INFO - 'tabpaint']}, 11:24:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:24:09 INFO - 'tests': ['a11yr', 11:24:09 INFO - 'ts_paint', 11:24:09 INFO - 'tpaint', 11:24:09 INFO - 'sessionrestore', 11:24:09 INFO - 'sessionrestore_no_auto_restore', 11:24:09 INFO - 'tabpaint']}, 11:24:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:24:09 INFO - 'tests': ['a11yr', 11:24:09 INFO - 'ts_paint', 11:24:09 INFO - 'tpaint', 11:24:09 INFO - 'sessionrestore', 11:24:09 INFO - 'sessionrestore_no_auto_restore', 11:24:09 INFO - 'tabpaint']}, 11:24:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:24:09 INFO - 'tests': ['tsvgx', 11:24:09 INFO - 'tsvgr_opacity', 11:24:09 INFO - 'tart', 11:24:09 INFO - 'tscrollx', 11:24:09 INFO - 'cart']}, 11:24:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:24:09 INFO - 'tsvgr_opacity', 11:24:09 INFO - 'tart', 11:24:09 INFO - 'tscrollx', 11:24:09 INFO - 'cart']}, 11:24:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:09 INFO - 'talos_options': ['--disable-e10s'], 11:24:09 INFO - 'tests': ['tp5o']}, 11:24:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:09 INFO - 'tests': ['tp5o']}, 11:24:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:09 INFO - 'talos_options': ['--disable-e10s', 11:24:09 INFO - '--xperf_path', 11:24:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:24:09 INFO - 'tests': ['tp5n']}, 11:24:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:09 INFO - 'talos_options': ['--xperf_path', 11:24:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:24:09 INFO - 'tests': ['tp5n']}}, 11:24:09 INFO - 'talos.zip': {'path': '', 11:24:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:24:09 INFO - Running post-action listener: _resource_record_post_action 11:24:09 INFO - [mozharness: 2016-08-05 18:24:09.338657Z] Finished populate-webroot step (success) 11:24:09 INFO - [mozharness: 2016-08-05 18:24:09.338744Z] Running create-virtualenv step. 11:24:09 INFO - Running pre-action listener: _resource_record_pre_action 11:24:09 INFO - Running main action method: create_virtualenv 11:24:09 INFO - Creating virtualenv /builds/slave/test/build/venv 11:24:09 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 11:24:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:24:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:24:09 INFO - Using real prefix '/usr' 11:24:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:24:09 INFO - Installing distribute.............................................................................................................................................................................................done. 11:24:11 INFO - Installing pip.................done. 11:24:11 INFO - Return code: 0 11:24:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:24:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fba180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb83b0>, '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 0x1fb92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb9740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1470421432.836438-1338878370', '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 11:24:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:24:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:24:11 INFO - Using env: {'DISPLAY': ':0', 11:24:11 INFO - 'HOME': '/home/cltbld', 11:24:11 INFO - 'LANG': 'en_US.UTF-8', 11:24:11 INFO - 'LANGUAGE': 'en_US:en', 11:24:11 INFO - 'LOGNAME': 'cltbld', 11:24:11 INFO - 'MAIL': '/var/mail/cltbld', 11:24:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:11 INFO - 'MOZ_NO_REMOTE': '1', 11:24:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:11 INFO - 'NO_EM_RESTART': '1', 11:24:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:11 INFO - 'PWD': '/builds/slave/test', 11:24:11 INFO - 'SHELL': '/bin/bash', 11:24:11 INFO - 'SHLVL': '1', 11:24:11 INFO - 'TERM': 'linux', 11:24:11 INFO - 'TMOUT': '86400', 11:24:11 INFO - 'USER': 'cltbld', 11:24:11 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470421432.836438-1338878370', 11:24:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:11 INFO - '_': '/tools/buildbot/bin/python'} 11:24:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:12 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:24:12 INFO - Cleaning up... 11:24:12 INFO - Return code: 0 11:24:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:24:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fba180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb83b0>, '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 0x1fb92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb9740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1470421432.836438-1338878370', '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 11:24:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:24:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:24:12 INFO - Using env: {'DISPLAY': ':0', 11:24:12 INFO - 'HOME': '/home/cltbld', 11:24:12 INFO - 'LANG': 'en_US.UTF-8', 11:24:12 INFO - 'LANGUAGE': 'en_US:en', 11:24:12 INFO - 'LOGNAME': 'cltbld', 11:24:12 INFO - 'MAIL': '/var/mail/cltbld', 11:24:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:12 INFO - 'MOZ_NO_REMOTE': '1', 11:24:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:12 INFO - 'NO_EM_RESTART': '1', 11:24:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:12 INFO - 'PWD': '/builds/slave/test', 11:24:12 INFO - 'SHELL': '/bin/bash', 11:24:12 INFO - 'SHLVL': '1', 11:24:12 INFO - 'TERM': 'linux', 11:24:12 INFO - 'TMOUT': '86400', 11:24:12 INFO - 'USER': 'cltbld', 11:24:12 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470421432.836438-1338878370', 11:24:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:12 INFO - '_': '/tools/buildbot/bin/python'} 11:24:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:12 INFO - Downloading/unpacking psutil>=3.1.1 11:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:24:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:24:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:24:14 INFO - Installing collected packages: psutil 11:24:14 INFO - Running setup.py install for psutil 11:24:14 INFO - building 'psutil._psutil_linux' extension 11:24:14 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:24:14 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 11:24:14 INFO - building 'psutil._psutil_posix' extension 11:24:14 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 11:24:14 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 11:24:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:24:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:24:14 INFO - Successfully installed psutil 11:24:14 INFO - Cleaning up... 11:24:14 INFO - Return code: 0 11:24:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:24:14 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')]} 11:24:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:14 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')]} 11:24:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:14 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 0x1cf9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fba180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb83b0>, '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 0x1fb92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb9740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1470421432.836438-1338878370', '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 11:24:14 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 11:24:14 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 11:24:14 INFO - Using env: {'DISPLAY': ':0', 11:24:14 INFO - 'HOME': '/home/cltbld', 11:24:14 INFO - 'LANG': 'en_US.UTF-8', 11:24:14 INFO - 'LANGUAGE': 'en_US:en', 11:24:14 INFO - 'LOGNAME': 'cltbld', 11:24:14 INFO - 'MAIL': '/var/mail/cltbld', 11:24:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:14 INFO - 'MOZ_NO_REMOTE': '1', 11:24:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:14 INFO - 'NO_EM_RESTART': '1', 11:24:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:14 INFO - 'PWD': '/builds/slave/test', 11:24:14 INFO - 'SHELL': '/bin/bash', 11:24:14 INFO - 'SHLVL': '1', 11:24:14 INFO - 'TERM': 'linux', 11:24:14 INFO - 'TMOUT': '86400', 11:24:14 INFO - 'USER': 'cltbld', 11:24:14 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470421432.836438-1338878370', 11:24:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:14 INFO - '_': '/tools/buildbot/bin/python'} 11:24:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:24:15 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 11:24:15 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 11:24:15 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 11:24:15 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 11:24:15 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 11:24:15 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 11:24:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:24:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:24:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:24:17 INFO - Installing collected packages: mozsystemmonitor 11:24:17 INFO - Running setup.py install for mozsystemmonitor 11:24:17 INFO - Successfully installed mozsystemmonitor 11:24:17 INFO - Cleaning up... 11:24:17 INFO - Return code: 0 11:24:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:24: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')]} 11:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24: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')]} 11:24:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:17 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 0x1cf9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fba180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb83b0>, '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 0x1fb92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb9740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1470421432.836438-1338878370', '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 11:24:17 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 11:24:17 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 11:24:17 INFO - Using env: {'DISPLAY': ':0', 11:24:17 INFO - 'HOME': '/home/cltbld', 11:24:17 INFO - 'LANG': 'en_US.UTF-8', 11:24:17 INFO - 'LANGUAGE': 'en_US:en', 11:24:17 INFO - 'LOGNAME': 'cltbld', 11:24:17 INFO - 'MAIL': '/var/mail/cltbld', 11:24:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:17 INFO - 'MOZ_NO_REMOTE': '1', 11:24:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:17 INFO - 'NO_EM_RESTART': '1', 11:24:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:17 INFO - 'PWD': '/builds/slave/test', 11:24:17 INFO - 'SHELL': '/bin/bash', 11:24:17 INFO - 'SHLVL': '1', 11:24:17 INFO - 'TERM': 'linux', 11:24:17 INFO - 'TMOUT': '86400', 11:24:17 INFO - 'USER': 'cltbld', 11:24:17 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470421432.836438-1338878370', 11:24:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:17 INFO - '_': '/tools/buildbot/bin/python'} 11:24:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:17 INFO - Downloading/unpacking jsonschema==2.5.1 11:24:17 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 11:24:17 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 11:24:17 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 11:24:17 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 11:24:17 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 11:24:17 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 11:24:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:24:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:24:19 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 11:24:19 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 11:24:19 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 11:24:19 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 11:24:19 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 11:24:19 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 11:24:19 INFO - Downloading functools32-3.2.3-2.tar.gz 11:24:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:24:19 INFO - warning: no files found matching '*.txt' 11:24:19 INFO - no previously-included directories found matching 'build' 11:24:19 INFO - no previously-included directories found matching 'dist' 11:24:19 INFO - no previously-included directories found matching '.git*' 11:24:19 INFO - Installing collected packages: jsonschema, functools32 11:24:19 INFO - Running setup.py install for functools32 11:24:19 INFO - warning: no files found matching '*.txt' 11:24:19 INFO - no previously-included directories found matching 'build' 11:24:19 INFO - no previously-included directories found matching 'dist' 11:24:19 INFO - no previously-included directories found matching '.git*' 11:24:19 INFO - Successfully installed jsonschema functools32 11:24:19 INFO - Cleaning up... 11:24:19 INFO - Return code: 0 11:24:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:24:19 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')]} 11:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:19 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')]} 11:24:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:19 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 0x1cf9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fba180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb83b0>, '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 0x1fb92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb9740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1470421432.836438-1338878370', '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 11:24:19 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 11:24:19 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 11:24:19 INFO - Using env: {'DISPLAY': ':0', 11:24:19 INFO - 'HOME': '/home/cltbld', 11:24:19 INFO - 'LANG': 'en_US.UTF-8', 11:24:19 INFO - 'LANGUAGE': 'en_US:en', 11:24:19 INFO - 'LOGNAME': 'cltbld', 11:24:19 INFO - 'MAIL': '/var/mail/cltbld', 11:24:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:19 INFO - 'MOZ_NO_REMOTE': '1', 11:24:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:19 INFO - 'NO_EM_RESTART': '1', 11:24:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:19 INFO - 'PWD': '/builds/slave/test', 11:24:19 INFO - 'SHELL': '/bin/bash', 11:24:19 INFO - 'SHLVL': '1', 11:24:19 INFO - 'TERM': 'linux', 11:24:19 INFO - 'TMOUT': '86400', 11:24:19 INFO - 'USER': 'cltbld', 11:24:19 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470421432.836438-1338878370', 11:24:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:19 INFO - '_': '/tools/buildbot/bin/python'} 11:24:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:24:19 INFO - Cleaning up... 11:24:19 INFO - Return code: 0 11:24:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:24:19 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')]} 11:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:19 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')]} 11:24:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:19 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 0x1cf9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fba180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb83b0>, '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 0x1fb92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb9740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1470421432.836438-1338878370', '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 11:24:19 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 11:24:19 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 11:24:19 INFO - Using env: {'DISPLAY': ':0', 11:24:19 INFO - 'HOME': '/home/cltbld', 11:24:19 INFO - 'LANG': 'en_US.UTF-8', 11:24:19 INFO - 'LANGUAGE': 'en_US:en', 11:24:19 INFO - 'LOGNAME': 'cltbld', 11:24:19 INFO - 'MAIL': '/var/mail/cltbld', 11:24:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:19 INFO - 'MOZ_NO_REMOTE': '1', 11:24:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:19 INFO - 'NO_EM_RESTART': '1', 11:24:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:19 INFO - 'PWD': '/builds/slave/test', 11:24:19 INFO - 'SHELL': '/bin/bash', 11:24:19 INFO - 'SHLVL': '1', 11:24:19 INFO - 'TERM': 'linux', 11:24:19 INFO - 'TMOUT': '86400', 11:24:19 INFO - 'USER': 'cltbld', 11:24:19 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470421432.836438-1338878370', 11:24:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:19 INFO - '_': '/tools/buildbot/bin/python'} 11:24:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:20 INFO - Downloading/unpacking blobuploader==1.2.4 11:24:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:22 INFO - Downloading blobuploader-1.2.4.tar.gz 11:24:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:24:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:24:22 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 11:24:22 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 11:24:22 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 11:24:22 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 11:24:22 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 11:24:22 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 11:24:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:24:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:24:22 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 11:24:22 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 11:24:22 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 11:24:22 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 11:24:22 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 11:24:22 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 11:24:22 INFO - Downloading docopt-0.6.1.tar.gz 11:24:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:24:22 INFO - Installing collected packages: blobuploader, requests, docopt 11:24:22 INFO - Running setup.py install for blobuploader 11:24:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:24:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:24:22 INFO - Running setup.py install for requests 11:24:23 INFO - Running setup.py install for docopt 11:24:23 INFO - Successfully installed blobuploader requests docopt 11:24:23 INFO - Cleaning up... 11:24:23 INFO - Return code: 0 11:24:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:24:23 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')]} 11:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:23 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')]} 11:24:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:23 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 0x1cf9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fba180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb83b0>, '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 0x1fb92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb9740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1470421432.836438-1338878370', '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 11:24:23 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 11:24:23 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 11:24:23 INFO - Using env: {'DISPLAY': ':0', 11:24:23 INFO - 'HOME': '/home/cltbld', 11:24:23 INFO - 'LANG': 'en_US.UTF-8', 11:24:23 INFO - 'LANGUAGE': 'en_US:en', 11:24:23 INFO - 'LOGNAME': 'cltbld', 11:24:23 INFO - 'MAIL': '/var/mail/cltbld', 11:24:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:23 INFO - 'MOZ_NO_REMOTE': '1', 11:24:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:23 INFO - 'NO_EM_RESTART': '1', 11:24:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:23 INFO - 'PWD': '/builds/slave/test', 11:24:23 INFO - 'SHELL': '/bin/bash', 11:24:23 INFO - 'SHLVL': '1', 11:24:23 INFO - 'TERM': 'linux', 11:24:23 INFO - 'TMOUT': '86400', 11:24:23 INFO - 'USER': 'cltbld', 11:24:23 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470421432.836438-1338878370', 11:24:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:23 INFO - '_': '/tools/buildbot/bin/python'} 11:24:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:24:23 INFO - Running setup.py (path:/tmp/pip-6IAeyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:24:23 INFO - Running setup.py (path:/tmp/pip-mbAD1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:24:23 INFO - Running setup.py (path:/tmp/pip-51uzK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:24:23 INFO - Running setup.py (path:/tmp/pip-vW4_D8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:24:23 INFO - Running setup.py (path:/tmp/pip-1175yK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:24:23 INFO - Running setup.py (path:/tmp/pip-kp9kLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:24:24 INFO - Running setup.py (path:/tmp/pip-CKDYg9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:24:24 INFO - Running setup.py (path:/tmp/pip-ddkQvl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:24:24 INFO - Running setup.py (path:/tmp/pip-Ma3n7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:24:24 INFO - Running setup.py (path:/tmp/pip-Jje6xm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:24:24 INFO - Running setup.py (path:/tmp/pip-wzk9cC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:24:24 INFO - Running setup.py (path:/tmp/pip-Ixi0v5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:24:24 INFO - Running setup.py (path:/tmp/pip-855V2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:24:24 INFO - Running setup.py (path:/tmp/pip-4TT7Oy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:24 INFO - Running setup.py (path:/tmp/pip-Z0b7wN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:24:24 INFO - Running setup.py (path:/tmp/pip-OtYd_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:24:24 INFO - Running setup.py (path:/tmp/pip-LBQH_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:24:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:24:24 INFO - Running setup.py install for manifestparser 11:24:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:24:24 INFO - Running setup.py install for mozcrash 11:24:25 INFO - Running setup.py install for mozdebug 11:24:25 INFO - Running setup.py install for mozdevice 11:24:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:24:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:24:25 INFO - Running setup.py install for mozfile 11:24:25 INFO - Running setup.py install for mozhttpd 11:24:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:24:25 INFO - Running setup.py install for mozinfo 11:24:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:24:25 INFO - Running setup.py install for mozInstall 11:24:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:24:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:24:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:24:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:24:25 INFO - Running setup.py install for mozleak 11:24:25 INFO - Running setup.py install for mozlog 11:24:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:24:25 INFO - Running setup.py install for moznetwork 11:24:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:24:25 INFO - Running setup.py install for mozprocess 11:24:26 INFO - Running setup.py install for mozprofile 11:24:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:24:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:24:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:24:26 INFO - Running setup.py install for mozrunner 11:24:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:24:26 INFO - Running setup.py install for mozscreenshot 11:24:26 INFO - Running setup.py install for moztest 11:24:26 INFO - Running setup.py install for mozversion 11:24:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:24:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:24:26 INFO - Cleaning up... 11:24:26 INFO - Return code: 0 11:24:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:24:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:26 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 0x1cf9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fba180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb83b0>, '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 0x1fb92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb9740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1470421432.836438-1338878370', '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 11:24:26 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 11:24:26 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 11:24:26 INFO - Using env: {'DISPLAY': ':0', 11:24:26 INFO - 'HOME': '/home/cltbld', 11:24:26 INFO - 'LANG': 'en_US.UTF-8', 11:24:26 INFO - 'LANGUAGE': 'en_US:en', 11:24:26 INFO - 'LOGNAME': 'cltbld', 11:24:26 INFO - 'MAIL': '/var/mail/cltbld', 11:24:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:26 INFO - 'MOZ_NO_REMOTE': '1', 11:24:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:26 INFO - 'NO_EM_RESTART': '1', 11:24:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:26 INFO - 'PWD': '/builds/slave/test', 11:24:26 INFO - 'SHELL': '/bin/bash', 11:24:26 INFO - 'SHLVL': '1', 11:24:26 INFO - 'TERM': 'linux', 11:24:26 INFO - 'TMOUT': '86400', 11:24:26 INFO - 'USER': 'cltbld', 11:24:26 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470421432.836438-1338878370', 11:24:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:26 INFO - '_': '/tools/buildbot/bin/python'} 11:24:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:24:26 INFO - Running setup.py (path:/tmp/pip-lSaXQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:24:26 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)) 11:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:24:26 INFO - Running setup.py (path:/tmp/pip-QN8WxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:24:26 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)) 11:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:24:26 INFO - Running setup.py (path:/tmp/pip-a_sVDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:24:27 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)) 11:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:24:27 INFO - Running setup.py (path:/tmp/pip-PLlJms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:24:27 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)) 11:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:24:27 INFO - Running setup.py (path:/tmp/pip-53Vr9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:24:27 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)) 11:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:24:27 INFO - Running setup.py (path:/tmp/pip-ZEHMzE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:24:27 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)) 11:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:24:27 INFO - Running setup.py (path:/tmp/pip-li58k5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:24:27 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)) 11:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:24:27 INFO - Running setup.py (path:/tmp/pip-H1HKzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:24:27 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)) 11:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:24:27 INFO - Running setup.py (path:/tmp/pip-qvn_nn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:24:27 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)) 11:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:24:27 INFO - Running setup.py (path:/tmp/pip-lIA1Dm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:24:27 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)) 11:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:24:27 INFO - Running setup.py (path:/tmp/pip-PVl1ZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:24:27 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)) 11:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:24:27 INFO - Running setup.py (path:/tmp/pip-jcu3Ie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:24:27 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)) 11:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:24:27 INFO - Running setup.py (path:/tmp/pip-wYu0CP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:24:27 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)) 11:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:24:27 INFO - Running setup.py (path:/tmp/pip-CLeWVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:24:27 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)) 11:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:27 INFO - Running setup.py (path:/tmp/pip-psgcaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:27 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)) 11:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:24:27 INFO - Running setup.py (path:/tmp/pip-Y_y8VL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:24:27 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)) 11:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:24:27 INFO - Running setup.py (path:/tmp/pip-Vvvg68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:24:28 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)) 11:24:28 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)) 11:24:28 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)) 11:24:28 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)) 11:24:28 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)) 11:24:28 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)) 11:24:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:24:28 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 11:24:28 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 11:24:28 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 11:24:28 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 11:24:28 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 11:24:28 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 11:24:29 INFO - Downloading blessings-1.6.tar.gz 11:24:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:24:30 INFO - Installing collected packages: blessings 11:24:30 INFO - Running setup.py install for blessings 11:24:30 INFO - Successfully installed blessings 11:24:30 INFO - Cleaning up... 11:24:30 INFO - Return code: 0 11:24:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:24:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:24:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:24:30 INFO - Reading from file tmpfile_stdout 11:24:30 INFO - Current package versions: 11:24:30 INFO - argparse == 1.2.1 11:24:30 INFO - blessings == 1.6 11:24:30 INFO - blobuploader == 1.2.4 11:24:30 INFO - docopt == 0.6.1 11:24:30 INFO - functools32 == 3.2.3-2 11:24:30 INFO - jsonschema == 2.5.1 11:24:30 INFO - manifestparser == 1.1 11:24:30 INFO - mozInstall == 1.12 11:24:30 INFO - mozcrash == 0.17 11:24:30 INFO - mozdebug == 0.1 11:24:30 INFO - mozdevice == 0.48 11:24:30 INFO - mozfile == 1.2 11:24:30 INFO - mozhttpd == 0.7 11:24:30 INFO - mozinfo == 0.9 11:24:30 INFO - mozleak == 0.1 11:24:30 INFO - mozlog == 3.3 11:24:30 INFO - moznetwork == 0.27 11:24:30 INFO - mozprocess == 0.23 11:24:30 INFO - mozprofile == 0.28 11:24:30 INFO - mozrunner == 6.12 11:24:30 INFO - mozscreenshot == 0.1 11:24:30 INFO - mozsystemmonitor == 0.3 11:24:30 INFO - moztest == 0.7 11:24:30 INFO - mozversion == 1.4 11:24:30 INFO - psutil == 3.1.1 11:24:30 INFO - requests == 1.2.3 11:24:30 INFO - wsgiref == 0.1.2 11:24:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:24:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:30 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 0x1cf9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fba180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb83b0>, '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 0x1fb92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb9740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1470421432.836438-1338878370', '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 11:24:30 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 11:24:30 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 11:24:30 INFO - Using env: {'DISPLAY': ':0', 11:24:30 INFO - 'HOME': '/home/cltbld', 11:24:30 INFO - 'LANG': 'en_US.UTF-8', 11:24:30 INFO - 'LANGUAGE': 'en_US:en', 11:24:30 INFO - 'LOGNAME': 'cltbld', 11:24:30 INFO - 'MAIL': '/var/mail/cltbld', 11:24:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:30 INFO - 'MOZ_NO_REMOTE': '1', 11:24:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:30 INFO - 'NO_EM_RESTART': '1', 11:24:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:30 INFO - 'PWD': '/builds/slave/test', 11:24:30 INFO - 'SHELL': '/bin/bash', 11:24:30 INFO - 'SHLVL': '1', 11:24:30 INFO - 'TERM': 'linux', 11:24:30 INFO - 'TMOUT': '86400', 11:24:30 INFO - 'USER': 'cltbld', 11:24:30 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470421432.836438-1338878370', 11:24:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:30 INFO - '_': '/tools/buildbot/bin/python'} 11:24:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:30 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)) 11:24:30 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)) 11:24:30 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)) 11:24:30 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)) 11:24:30 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)) 11:24:30 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)) 11:24:30 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)) 11:24:30 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)) 11:24:30 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)) 11:24:30 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)) 11:24:30 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)) 11:24:30 INFO - Cleaning up... 11:24:30 INFO - Return code: 0 11:24:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:24:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:30 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 0x1cf9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fba180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb83b0>, '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 0x1fb92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb9740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1470421432.836438-1338878370', '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 11:24:30 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 11:24:30 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 11:24:30 INFO - Using env: {'DISPLAY': ':0', 11:24:30 INFO - 'HOME': '/home/cltbld', 11:24:30 INFO - 'LANG': 'en_US.UTF-8', 11:24:30 INFO - 'LANGUAGE': 'en_US:en', 11:24:30 INFO - 'LOGNAME': 'cltbld', 11:24:30 INFO - 'MAIL': '/var/mail/cltbld', 11:24:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:30 INFO - 'MOZ_NO_REMOTE': '1', 11:24:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:30 INFO - 'NO_EM_RESTART': '1', 11:24:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:30 INFO - 'PWD': '/builds/slave/test', 11:24:30 INFO - 'SHELL': '/bin/bash', 11:24:30 INFO - 'SHLVL': '1', 11:24:30 INFO - 'TERM': 'linux', 11:24:30 INFO - 'TMOUT': '86400', 11:24:30 INFO - 'USER': 'cltbld', 11:24:30 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470421432.836438-1338878370', 11:24:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:30 INFO - '_': '/tools/buildbot/bin/python'} 11:24:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:24:30 INFO - Cleaning up... 11:24:30 INFO - Return code: 0 11:24:30 INFO - Running post-action listener: _resource_record_post_action 11:24:30 INFO - Running post-action listener: _start_resource_monitoring 11:24:30 INFO - Starting resource monitoring. 11:24:30 INFO - [mozharness: 2016-08-05 18:24:30.884552Z] Finished create-virtualenv step (success) 11:24:30 INFO - [mozharness: 2016-08-05 18:24:30.885045Z] Running install step. 11:24:30 INFO - Running pre-action listener: _resource_record_pre_action 11:24:30 INFO - Running main action method: install 11:24:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:24:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:24:31 INFO - Reading from file tmpfile_stdout 11:24:31 INFO - Detecting whether we're running mozinstall >=1.0... 11:24:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:24:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:24:31 INFO - Reading from file tmpfile_stdout 11:24:31 INFO - Output received: 11:24:31 INFO - Usage: mozinstall [options] installer 11:24:31 INFO - Options: 11:24:31 INFO - -h, --help show this help message and exit 11:24:31 INFO - -d DEST, --destination=DEST 11:24:31 INFO - Directory to install application into. [default: 11:24:31 INFO - "/builds/slave/test"] 11:24:31 INFO - --app=APP Application being installed. [default: firefox] 11:24:31 INFO - mkdir: /builds/slave/test/build/application 11:24:31 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'] 11:24:31 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 11:24:48 INFO - Reading from file tmpfile_stdout 11:24:48 INFO - Output received: 11:24:48 INFO - /builds/slave/test/build/application/firefox/firefox 11:24:48 INFO - Running post-action listener: _resource_record_post_action 11:24:48 INFO - [mozharness: 2016-08-05 18:24:48.243409Z] Finished install step (success) 11:24:48 INFO - [mozharness: 2016-08-05 18:24:48.243662Z] Running run-tests step. 11:24:48 INFO - Running pre-action listener: _resource_record_pre_action 11:24:48 INFO - Running main action method: run_tests 11:24:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:24:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:24:48 INFO - Python 2.7.3 11:24:48 INFO - Return code: 0 11:24:48 INFO - grabbing minidump binary from tooltool 11:24: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')]} 11:24:48 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 0x1fb83b0>, '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 0x1fb92b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb9740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:24:48 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 11:24:48 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 11:24:48 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 11:24:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:24:48 INFO - Return code: 0 11:24:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:24:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:24:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:24:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:24:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:24:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H3M2V4CaRMm8vgmUv0o7Hw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 11:24:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/H3M2V4CaRMm8vgmUv0o7Hw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --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 11:24:48 INFO - Using env: {'DISPLAY': ':0', 11:24:48 INFO - 'HOME': '/home/cltbld', 11:24:48 INFO - 'LANG': 'en_US.UTF-8', 11:24:48 INFO - 'LANGUAGE': 'en_US:en', 11:24:48 INFO - 'LOGNAME': 'cltbld', 11:24:48 INFO - 'MAIL': '/var/mail/cltbld', 11:24:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:24:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:24:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:48 INFO - 'MOZ_NO_REMOTE': '1', 11:24:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:24:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:48 INFO - 'NO_EM_RESTART': '1', 11:24:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:48 INFO - 'PWD': '/builds/slave/test', 11:24:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:24:48 INFO - 'SHELL': '/bin/bash', 11:24:48 INFO - 'SHLVL': '1', 11:24:48 INFO - 'TERM': 'linux', 11:24:48 INFO - 'TMOUT': '86400', 11:24:48 INFO - 'USER': 'cltbld', 11:24:48 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1470421432.836438-1338878370', 11:24:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:48 INFO - '_': '/tools/buildbot/bin/python'} 11:24:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H3M2V4CaRMm8vgmUv0o7Hw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 11:24:48 INFO - mozversion application_buildid: 20160805083002 11:24:48 INFO - mozversion application_changeset: bfb4f7467dd4b39005d61fbcb2872da14a29d66b 11:24:48 INFO - mozversion application_display_name: Nightly 11:24:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:24:48 INFO - mozversion application_name: Firefox 11:24:48 INFO - mozversion application_remotingname: firefox 11:24:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:24:48 INFO - mozversion application_vendor: Mozilla 11:24:48 INFO - mozversion application_version: 51.0a1 11:24:48 INFO - mozversion platform_buildid: 20160805083002 11:24:48 INFO - mozversion platform_changeset: bfb4f7467dd4b39005d61fbcb2872da14a29d66b 11:24:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:24:48 INFO - mozversion platform_version: 51.0a1 11:24:48 INFO - using testdate: 1470421488 11:24:48 INFO - actual date: 1470421488 11:24:48 INFO - starting webserver on 'localhost:49551' 11:24:48 INFO - SUITE-START | Running 2 tests 11:24:48 INFO - TEST-START | dromaeo_css 11:24:48 INFO - operating with platform_type : linux_ 11:24:48 INFO - Initialising browser for dromaeo_css test... 11:24:48 INFO - TEST-INFO | started process 9033 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcuHd1K/profile http://localhost:49551/getInfo.html) 11:24:52 INFO - PROCESS | 9033 | __metrics Screen width/height:1600/1200 11:24:52 INFO - PROCESS | 9033 | colorDepth:24 11:24:52 INFO - PROCESS | 9033 | Browser inner width/height: 1024/697 11:24:52 INFO - PROCESS | 9033 | __metrics 11:24:53 INFO - PROCESS | 9033 | 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" 11:24:53 INFO - PROCESS | 9033 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:24:53 INFO - PROCESS | 9033 | console.error: PushService: 11:24:53 INFO - PROCESS | 9033 | stateChangeProcessEnqueue: Error transitioning state 11:24:53 INFO - PROCESS | 9033 | UnknownError 11:24:54 INFO - TEST-INFO | 9033: exit 0 11:24:54 INFO - Browser initialized. 11:24:54 INFO - Running cycle 1/1 for dromaeo_css test... 11:24:54 INFO - TEST-INFO | started process 9113 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcuHd1K/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:25:06 INFO - PROCESS | 9113 | RSS: Main: 156766208 11:25:06 INFO - PROCESS | 9113 | 11:25:57 INFO - PROCESS | 9113 | 1470421557020 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] 11:28:07 INFO - PROCESS | 9113 | Cycle 1(1): loaded http://localhost:49551/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49551/tests/dromaeo/cssquery-ext.html) 11:28:08 INFO - PROCESS | 9113 | RSS: Main: 261226496 11:28:08 INFO - PROCESS | 9113 | 11:31:11 INFO - PROCESS | 9113 | Cycle 1(1): loaded http://localhost:49551/tests/dromaeo/cssquery-ext.html (next: http://localhost:49551/tests/dromaeo/cssquery-jquery.html) 11:31:11 INFO - PROCESS | 9113 | RSS: Main: 238338048 11:31:11 INFO - PROCESS | 9113 | 11:34:13 INFO - PROCESS | 9113 | Cycle 1(1): loaded http://localhost:49551/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49551/tests/dromaeo/cssquery-mootools.html) 11:34:14 INFO - PROCESS | 9113 | RSS: Main: 186486784 11:34:14 INFO - PROCESS | 9113 | 11:37:16 INFO - PROCESS | 9113 | Cycle 1(1): loaded http://localhost:49551/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49551/tests/dromaeo/cssquery-prototype.html) 11:37:17 INFO - PROCESS | 9113 | RSS: Main: 216522752 11:37:17 INFO - PROCESS | 9113 | 11:40:19 INFO - PROCESS | 9113 | Cycle 1(1): loaded http://localhost:49551/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49551/tests/dromaeo/cssquery-yui.html) 11:40:20 INFO - PROCESS | 9113 | RSS: Main: 186220544 11:40:20 INFO - PROCESS | 9113 | 11:43:23 INFO - PROCESS | 9113 | Cycle 1(1): loaded http://localhost:49551/tests/dromaeo/cssquery-yui.html (next: http://localhost:49551/tests/dromaeo/cssquery-dojo.html) 11:43:23 INFO - PROCESS | 9113 | RSS: Main: 276385792 11:43:23 INFO - PROCESS | 9113 | 11:43:23 INFO - PROCESS | 9113 | __start_tp_report 11:43:23 INFO - PROCESS | 9113 | _x_x_mozilla_page_load 11:43:23 INFO - PROCESS | 9113 | _x_x_mozilla_page_load_details 11:43:23 INFO - PROCESS | 9113 | |i|pagename|runs| 11:43:23 INFO - PROCESS | 9113 | |0;dojo.html;3027.1523973287485;3036.1498780341503;3047.0706434537465;3067.432524982877;3082.9075127746178;5185.429602743695;5208.036513245052;5214.165733482639;5312.150055991042;5324.201369794528;5267.446918073595;5271.894562108756;5315.920261196075;5337.5196232339085;5344.465553444654;4760.404949381336;4791.784369703354;4829.420469543659;4835.516448355172;4975.4527002029745;4880.731559764212;4895.388076490439;4923.82766603169;4942.6293028022865;4948.57937075349;4757.0723708876785;4765.976170119127;4801.567858892681;4826.083044221622;4873;4758.547937945889;4759.976200118977;4782.187028205213;4893.1926232171645;4924.778384972685;4760.833370832039;4793.3768610080815;4803.063402636487;4846.030793841211;4864.902701945941;5121.82073627425;5187.299714538527;5226.320578324831;5253.842384728464;5282.3925248596515;5601.831945041656;5635.520980716644;5639.915401268984;5693.572982026365;5695.971520142372;5662.2639056922335;5720.856978575527;5729.255196824386;5730.111832665943;5732.226149469851;5105.310783044241;5203.817866374735;5241.266222728821;5283.762230699589;5330.520253177233;5789.623674461231;5805.100209467455;5830.329512106077;5851.1515830205235;5851.32709738377;5574.498295153375;5616;5625.353084395265;5630.690312032878;5632.633878797865;5464.672119672832;5522.061249587579;5565.1374037024325;5641.80253691127;5691.9146212806845;5588.860278492989;5592.384837667853;5594.3286805582775;5619.100943848965;5642.6614403135945;5547.583931205095;5583.302087239095;5583.944160558342;5594.664320140804;5605.747741351649;4241.172971270635;4292.077203401283;4319.784010799447;4324.005478739908;4362.1493808707;3864.9033774155873;3886.1644746379666;3900.6684431823614;3902.200048990007;3947.842086316515;5329.7068661224;5334.893302133935;5336.226247194135;5342.626016178908;5344.706041167773;5516.503514683698;5596.27248457706;5644.322681278273;5650.29371328584;5650.5479561634975;5320.467953204648;5344.25180474726;5346.625736198506;5350.224217488442;5374.220737992969;4811.807527698853;4811.807527698923;4815.638827087912;4822.590079843252;4861.975690121527;5743.224664670383;5800.883982320245;5886.381929897385;5899.67551784656;5901.085331773496;5607.719614019365;5637.323521177321;5649.435056494318;5679.829605111853;5695.743691533974;5861.062230043172;5875.383084776208;5876.853078672896;5880.14737863016;5882.382349853204;5459.181122831607;5482.095454250004;5529.529989950738;5544.0575102231915;5553.111502159635;5622.100463925753;5665.20687103814;5668.659880407189;5720.313562372542;5723.370429252862;5480.123180291134;5495.560355171657;5504.339479262514;5541.833744987657;5544.889102218014;5423.457654234703;5449.373322067854;5458.153986132156;5492.5331346835965;5552.444755524415;5419.756110974937;5453.2365468833605;5460.3993560707495;5507.146392309199;5508.256385387921;5580.972095139661;5589.776408943597;5629.380768115586;5636.154576813511;5639.351474580311;5333.466653334635;5392.892142157057;5446.836594902159;5463.043967305626;5465.617406781487 11:43:23 INFO - PROCESS | 9113 | |1;ext.html;568.7459152568587;582.4990508162982;584.9532037437006;598.2312728144335;614.2138063279002;33315.33369332615;33943;44703.77648111759;45383.09233815322;45480;46180.76909615447;46772.298415523794;46831.53168468314;46840.76579617106;46879.06241875161;8910.866337004934;9048.547572621343;9052.773680658003;9059.184673379394;9065.04816994216;8915.910840891573;9000.549972501349;9001.774955626097;9024.278057755397;9024.729258122266;9067.36528443006;9094.181523662868;9096.090390960917;9100.8634870477;9102.271818254558;8980.64077436905;9024.05247449015;9024.323175761778;9033.05152958943;9040.954795226047;8924.55377231136;8926.553672316359;8928.062553431926;8963.10368963105;8984.146506081977;42760.3585946211;42783;42870.78564607188;42958.35562466565;43137;3544.805035723034;3604.9906026312674;3653.561572611277;3794.90512737181;4234.470691163605;33012.6698733012;33110.668893311;33519.32961340759;33585.32829343424;33691;4370.104128653618;4404.4934832494355;4415.161119387306;4446.73319600825;4544.182047231497;245444;245641.77179114168;246535;246997.88509517114;247313;57615.711921440125;57866.71066644724;57887.263382097764;57894;58073.70963145242;37000.259994799955;38196.80901595474;38200.426993595116;39524.60475395267;39745.60254397477;17684.115794210236;17783.822161778477;17785.377511787025;17789.19948602316;17804.109794510223;13537.932310338385;13608.183508989492;13608.86391136076;13613.251271180181;13633.727325453634;19365.355465546578;19562.804371956383;19566.78051411116;19615.509612259808;19638.91985940787;7129.7861064168155;7135.643217839087;7239.334952960849;7239.746608868664;7279.162896266891;937.2408349237139;938.9154976052188;1063.8351055586397;1070.5289672544056;1115.4980258883536;29659.406811864075;29812.850935745617;30089.247768805955;30254;30393.088207353816;1083.1389045708681;1103.8840921703265;1134.8581427321585;1137.4767606900753;1219.1587804414926;15747.606309842346;16345.673086538203;16406.83593164077;16487;16782.74825877613;589266;594227;595762;600150;601563;62069.68965155145;62437.375626244066;62481.375186248464;62671.686641567416;62707.6864615674;1243.12980913361;1278.0733967873218;1289.374653293171;1400.1669006940854;1404.6909679870412;20576.279830205873;29890.402191956473;30466.543001854545;32238.677613224507;33035.504467432525;57430;58069.70965145147;58125.128123079034;58177.12734308904;58245;504922;506522;508435;510727;511007;29390.559141612466;29605.555916660836;29861;30397.84801076069;30483.037205163186;49362.506374935794;49570.752146239036;49946.25080623721;50097.998040039725;51060;40992.59007410007;41742.582574173866;41837.58162418337;42067;43512.56487435085;41241.1751764957;41584;41639.37540936949;42725.572744273406;42899;27891.860540697166;28993.7100628991;34929.30141397107;35134.472982904765;36072;36986.8150659245;38274.617253827106;38515.229695405375;39191;39218.80390598029;25954.480910382063;26006.73993260043;26622.334441639116;26694;26926.192214233604 11:43:23 INFO - PROCESS | 9113 | |2;jquery.html;381.8548951398468;384.93840985442324;388.1906225519791;403.27209387056365;417.5135966598912;13388.741444335797;19140.330088446906;20698;20717.482062948417;20801.687974680393;16171.35314587418;19287;19838.40484785459;19961.301354452597;20347.796522034776;5700.315962084555;5859.417957151567;5861.5603829712945;5890.469857712805;5891.558133140032;5523.143912693539;5606.943930560683;5742.253507044078;5814.389489103647;5816.796412125576;5633.859153521174;5640.210370548127;5640.520555752766;5642.689652069134;5642.943570564304;5471.480209380103;5639.323281206261;5645.604807663465;5703.971480142614;5738;5070.31550740649;5104.566111880495;5107.3105130807235;5122.692638441706;5124.0776660201145;24204.636930446057;24560.385990350205;24743.752562474503;24817;24920;2428.7034001847624;2482.6524286599893;2542.8601426921514;3081.876724931;3173.2701478659806;10012.399256044588;10539.367637941748;10554.630587929385;10728.409937453436;14696.632584185374;1843.5575461889184;1894.1760334254507;1918.3285849952545;1983.6925276582153;2048.4673984764067;87250.12749872483;87712;87987.12012879853;88259.55870220672;89185;10364.740881478023;10654.869026194792;10755.40845253503;10987.83518247211;11754.177207595387;15061.096334219981;15067.773983390258;15074.773878391832;15101.924490377478;15107.773383399257;7940.444168908237;8277.793055173548;8364.330853531703;8396.286315663116;8474.194951479723;7988.640511177011;8116.75649730509;8126.918730812735;8314.875276870851;8315.8336833263;4170.666346692257;4355.2813785725;4506.233940230103;4610.515895830957;4675.345451636774;1833.2575307000686;1837.5773572078497;1903.45751460833;1945.309415157627;1961.1469010979984;885.7918389178537;925.9444433334022;946.5267366316841;988.9764094162507;1027.6557353286582;17870.46388608344;18448.631027379644;20195.798042019687;20228.19087236494;20326.695099573517;977.6431602465049;998.5356809083665;1029.6602121299952;1055.6199768083484;1100.3782862682558;10694.358338499715;11134.49894754738;11227.55089796399;11237.38194399316;11365.602203922823;530831;555151;566727;578668;584861.2111031107;96988;97873;99570;100307;102253.48873255587;1035.3115178406426;1064.9680509584725;1069.053887309721;1071.7802850415646;1080.2114456446996;17018.404355847484;17220.913895430946;17728.202230899897;17767.64464710673;17777.911110444365;44907;44960.32559511675;45345.54654453413;45643.31535027044;46686.299705505124;58745.412545875704;61847;62786.686066569375;63534.364656352845;65924;8372.372072094495;8497.702580409656;8555.187257210555;8598.742037738877;8945.284377249674;12994.870051299366;13229.272390018641;13264;13294.468221271427;13685.726285474433;10524.94737526338;10774.353538787698;10825.783484330112;10907.890921090688;11527.193096483501;10967.670969870916;11482.540698371971;11503.257524281438;11764.647060588197;12100.939495302819;8968.10318968124;10664.146868250366;11121.777564448505;11185.32888026721;11304.265222760494;8507.702230421906;8551.486910785372;8581.155051663922;8711.738647840575;8758.47449153053;9999.700008999742;11013.504392302206;11222.438878055902;11281.661550153509;11387.886121138683 11:43:23 INFO - PROCESS | 9113 | |3;mootools.html;1322.10097133949;1455.6288146522636;1513.8410466900975;1640.2864753832077;1783.8572914166868;8535.530545819978;8940;8965.686200982975;9171.862422063658;9177.632894684204;8958.955205223965;9086.681966131187;9098.13567711068;9100.635974561026;9108.635654573809;2386.7255265644458;2408.157144999254;2413.1915808204185;2413.662087307778;2413.9034438622434;2347.9413014674683;2400;2407.987960060197;2408.0488207158164;2410.4576470294132;2326.9528712079546;2377.5720370333333;2384.904603815854;2397.9520409591796;2402;2301.5627030864084;2315.722113346401;2320.0835669910375;2322.698049253603;2340.157543284416;2303.8272129590346;2323.581755284048;2332.1137967572213;2336.158982766203;2341.0518739910362;8873.423227490193;8969.372143949926;9002.05478424769;9012.369134160612;9047;5267.130923397634;5486.698231597261;5494.5054945054735;5496.697681627509;5498.147787093007;3432.7940323580665;3448.3103379323984;3463.4977928200524;3485;3508.7894726316504;1159.0611604600301;1172.144334635712;1184.9585264515702;1208.0758219961735;1210.7699537088013;12724.363781810873;12772.744545109139;12787.296698681568;12793.55222567215;12834.294113823737;4413.867583972486;4583.083383323348;4670.439547254351;4671.649626278043;4703.153432382204;10036.899631003596;10048.346857454242;10059.39643621385;10061.949690251502;10092.747681308027;5355.0896347621;5355.196720491879;5363.356397232357;5364.034473794676;5370.812021579304;4409.757463339483;4776.307435421844;4895.216765317603;4921.409430868319;5007.69953802773;3861.362875125629;3921.117748506563;4004.699647526389;4038.51537815464;4040.959590404117;1165.8367828504017;1199.4542483170312;1204.5904392506416;1216.4282787090053;1220.8219068598844;946.6875930942772;971.917387022111;973.7711637765119;973.8587904753771;1000.2398177385094;5717.971410143005;5888.175655408247;5911.3201981772645;5941.494972927263;6011.09833524966;428.39565825981276;448.83841816945875;461.7737308718704;463.8237469761469;466.855274864793;4074.2258970795456;4106.466159399319;4130.297849365615;4172.645325147397;4174.7077704561;11209.383483908463;11561.248518846249;11631.302121872546;11639.301641901513;11648.650540483799;11511.769764604662;11523.654290371302;11524.423778811026;11526.077913766878;11527.308361498337;7801.882971755428;8084.029916410069;8136.593170341577;8560.743177704679;8660.350473714496;5795.913061304;5881.794137205177;5883.764649413975;5929.318128415288;5966.850828729316;10027.348222365523;10199.0820826126;10234.232432567736;10648.041676249175;10653.89346106529;10427.113695335982;10544.367337959748;10704.785904282027;10726.785464290826;10850.131989440984;7362.3741981932135;7683.34691551202;7853.803654908673;7895.368370530458;8031.397645176752;9011.594478248626;9042;9125.726228213165;9127.863082053642;9138.360314777901;7691.807704807425;7814.492058016211;7862.449628526177;8052.15452377492;8168.847379911351;7661.272179142972;7790.376769858511;7866.488678235896;7960.124386317616;8027.1972802719265;6640.535162538769;6705.262421133769;6714.697838597177;6727.192736871607;6729.528932974645;4999.725015124203;5010.473900240568;5166;5177.689338639693;5521.365043019943;5158.8968220636125;5225.425203227718;5281.524662780214;5290.153575427913;5493.203485494501 11:43:23 INFO - PROCESS | 9113 | |4;prototype.html;315.5424634280294;329.2706654759707;330.17291684330746;330.33767296570375;340.15980528095594;5294.311739473867;5316.308879845625;5324.896665817;5331.840044798652;5346.839594812152;4935.235038569019;5004.349434573501;5168.715720635363;5185.144451165563;5290.656107353019;4104.56902025286;4111.773852438115;4121.5878412158845;4124.896877578055;4149.087200815816;4138.420621113047;4149.751014939114;4164.6464898907825;4178.913482494543;4183.309753890604;3851.9792255052434;3874.5544262409903;4038.4144299076615;4059.2287465381633;4099.815508302118;4006.2187873364705;4022.5776293489203;4037.7375470594316;4044.757314561136;4048.5344185418758;3599.4960705501253;3604.8197590120653;3628.8004159771203;3633.291508155911;3633.418653015531;4877.853664390039;5076.873078173038;5088.211327244283;5125.2312153176945;5147.3051138096625;4535.750533720644;4537.931931021038;4576.26779715244;4591.127685739699;4617.153138744496;5374.8925021499745;5397.78408863645;5422.674639521601;5452.972735136339;5471.917921231185;3804.5814960354337;3878.3600705883778;3879.7478163919254;3896.5908579599018;3940.7438516496622;5609.803656872031;5610.410906854762;5644.322681278232;5653.604247702662;5667.178259152441;3958.960410395859;3968.583298753647;3969.4244334571904;3989.92020159601;3993.121513267077;3945.9013524662114;4044.5348784890116;4046.433499310099;4055.2497787909333;4061.3704875744306;4596.2416201326405;4599.793009314589;4630.305454181899;4649.558291962258;4653.767311634405;5375.892482150335;5458.181272809031;5459.727013649302;5472.863178420492;5488.615796894179;1374.6046766441677;1376.6076668149528;1386.2860626777217;1398.2519352146553;1402.9649258768409;882.5807741322949;894.1134206823597;896.7444278380631;897.6454300551246;906.4787747045475;4738.265568836836;4760.381150450419;4761.547652972962;4762.880927976759;4773.880652983703;4916.877078073006;4967.751612419364;5001.349824522788;5029.699606836102;5056.595472362203;4749;4751.857444276678;4929.482404347564;5316.813911513156;5355.598330125256;2973.539101439237;2974.0668565432643;2977.3003344214094;2980.6274215723033;2990.20759498733;5719.19931209631;5843.305441422025;5849.61977471463;5870.417016512721;5887.587868849225;5708.80019199326;5713.657180569179;5718.456746609066;5724.4561766632105;5728.283964504437;5800.5939584229545;5813.761701744774;5828.708564571754;5850.0932355484965;5860.882782344244;5362.731863406892;5539.556835453234;5547;5586.972065139648;5629.4652008059165;5477.67133971963;5498.505134537911;5506.834794956158;5516.14499752539;5523.1991361253195;5825.475707186373;5828.271466066742;5832.825015249549;5838.211841401527;5844.298684157929;3744.925101498009;3897.610238976193;3950.6049395060263;3987.12605075614;3991;5429.755660995185;5504.80733174337;5620.297462817148;5672.9505041567445;5706.600537962303;5453.372862120748;5476;5487.341519017744;5495.313085864267;5496.230527726201;5437.374701909331;5449.918251226156;5457.945420545744;5483.232347471437;5483.369412517612;5214.2960700304975;5341.172118321666;5351.759170837244;5364.678119312854;5374;5413.53984911287;5462.781488740406;5471.480209380262;5480.561555075505;5528.170774383874;5212.739363031909;5365.631763900181;5368.302120724281;5378.919316210338;5422.213779001943 11:43:23 INFO - PROCESS | 9113 | |5;yui.html;771.9134623493752;813.1665043330589;852.2159613155897;869.6564856881532;881.4314766975299;15928.84071159288;17811.46565603034;18040.63918721625;18052.729209061876;18136.183871725756;15136;15357.923210383933;15368.846311536881;15388.384464621402;15390;821.6549049399266;841.3437518735396;841.4698739793921;841.6296829395077;842.4397775479299;677.0893148714971;804.9758507244792;832.9416940814145;834.4242472693852;835.4736515994915;879.1077056787366;881.5019513974615;883.2977782662766;883.5405589093667;885.5749240364629;873.9825203495958;875.1948207648978;877.1053525404116;878.1876763993345;878.3763527895202;517.3791450259704;614.4070971512512;631.4190944331226;635.7870113511979;642.418611156899;15578.143202123878;15655.452059177987;15698.37206511738;15711.21443927799;15720.056796592242;13848.584542463743;14326.426942922271;14688.779668304984;14702.117872927658;14851.851481485155;11548.191626586142;11620.767584648343;12005.09961752872;12212.633620991295;12545.56090536836;4453.844115455976;4470;4485.1254005468945;4689.648276379251;4700;70436.64781676058;72618.63690681513;74074;84477.15522844755;85311;11330.886691133148;11527.250728702607;11636.94181529087;11694.239874408137;11930.105242106876;21648.458788530414;21661.241856534947;21664.566708665738;21678.24126155577;21772.56454870894;8264.504129752235;8373.539455329894;8620.827583448296;8844.292456603456;8893.955530222436;4338.501072376654;4460.1525710114975;4540.137373898949;4669.533046695304;4696.459907110658;3524.2775231077567;3665.0654083209142;3666.358387282215;3671.9265614687556;3673.8530458781884;622.1911515030442;624.406813527151;624.8000639795313;636.0395802338502;636.3254949753184;663.2538394306405;669.608279156689;678.5589366911448;701.1971292869636;711.1466240511407;8836.204741573289;8927.395045215893;9107.18035376806;9299.95350023259;9726.513674316397;611.2878496551468;643.8422586466346;657.7204688007578;695.7564852301654;711.3135823929932;4442.311441726538;4459.989085677406;4505.954940450553;4545;4550.251906724764;123305.38347308207;123340;131580;136017;142016.2899185518;113674;115113;115697.4215128919;115987;116452;90754.54622726844;96140;98276;98359;101950.99999999852;8128.796780080545;8283.25450709439;8347.081820999563;8455.450395724258;8571.513783813469;57350.7132464335;57849.71075144597;58069.419305806405;58092.4190758087;59193.19278283053;75055;87350;88250.55874720842;89018;89694.55152724456;11336.263142895685;11438.370889601152;11482.655520334403;11519.078473721915;11609;12531.310777907303;12533.811992820298;12673.953293914035;12809.743805124031;12895.742085158057;10162;11512.769744605228;11616.535338586362;11639.6508104757;11882.643520694393;13290.20258784476;13523.323833808074;13673.863261367656;13793.172409655454;13999.650008749863;12541.623751287476;12808.359582020676;13067.281299528617;13685.931570342085;13695.315234238447;10367.94816025915;10515.369077855354;10736.409497477402;10809.56761729522;11085.224034317844;10889.945550272198;11194.160437967023;11234.775304494027;11278.605248816251;11285.153613478858 11:43:23 INFO - PROCESS | 9113 | __end_tp_report 11:43:23 INFO - PROCESS | 9113 | __start_cc_report 11:43:23 INFO - PROCESS | 9113 | _x_x_mozilla_cycle_collect,976 11:43:23 INFO - PROCESS | 9113 | __end_cc_report 11:43:23 INFO - PROCESS | 9113 | __startTimestamp1470422603510__endTimestamp 11:43:23 INFO - PROCESS | 9113 | 11:43:23 INFO - PROCESS | 9113 | ------- Summary: start ------- 11:43:23 INFO - PROCESS | 9113 | Number of tests: 6 11:43:23 INFO - PROCESS | 9113 | 11:43:23 INFO - PROCESS | 9113 | [#0] dojo.html Cycles:165 Average:5249.21 Median:5458.15 stddev:591.26 (10.8%) stddev-sans-first:566.79 11:43:23 INFO - PROCESS | 9113 | Values: 3027.2 3036.1 3047.1 3067.4 3082.9 5185.4 5208.0 5214.2 5312.2 5324.2 5267.4 5271.9 5315.9 5337.5 5344.5 4760.4 4791.8 4829.4 4835.5 4975.5 4880.7 4895.4 4923.8 4942.6 4948.6 4757.1 4766.0 4801.6 4826.1 4873.0 4758.5 4760.0 4782.2 4893.2 4924.8 4760.8 4793.4 4803.1 4846.0 4864.9 5121.8 5187.3 5226.3 5253.8 5282.4 5601.8 5635.5 5639.9 5693.6 5696.0 5662.3 5720.9 5729.3 5730.1 5732.2 5105.3 5203.8 5241.3 5283.8 5330.5 5789.6 5805.1 5830.3 5851.2 5851.3 5574.5 5616.0 5625.4 5630.7 5632.6 5464.7 5522.1 5565.1 5641.8 5691.9 5588.9 5592.4 5594.3 5619.1 5642.7 5547.6 5583.3 5583.9 5594.7 5605.7 4241.2 4292.1 4319.8 4324.0 4362.1 3864.9 3886.2 3900.7 3902.2 3947.8 5329.7 5334.9 5336.2 5342.6 5344.7 5516.5 5596.3 5644.3 5650.3 5650.5 5320.5 5344.3 5346.6 5350.2 5374.2 4811.8 4811.8 4815.6 4822.6 4862.0 5743.2 5800.9 5886.4 5899.7 5901.1 5607.7 5637.3 5649.4 5679.8 5695.7 5861.1 5875.4 5876.9 5880.1 5882.4 5459.2 5482.1 5529.5 5544.1 5553.1 5622.1 5665.2 5668.7 5720.3 5723.4 5480.1 5495.6 5504.3 5541.8 5544.9 5423.5 5449.4 5458.2 5492.5 5552.4 5419.8 5453.2 5460.4 5507.1 5508.3 5581.0 5589.8 5629.4 5636.2 5639.4 5333.5 5392.9 5446.8 5463.0 5465.6 11:43:23 INFO - PROCESS | 9113 | 11:43:23 INFO - PROCESS | 9113 | [#1] ext.html Cycles:180 Average:60665.01 Median:23150.74 stddev:126690.42 (547.2%) stddev-sans-first:126965.47 11:43:23 INFO - PROCESS | 9113 | Values: 568.7 582.5 585.0 598.2 614.2 33315.3 33943.0 44703.8 45383.1 45480.0 46180.8 46772.3 46831.5 46840.8 46879.1 8910.9 9048.5 9052.8 9059.2 9065.0 8915.9 9000.5 9001.8 9024.3 9024.7 9067.4 9094.2 9096.1 9100.9 9102.3 8980.6 9024.1 9024.3 9033.1 9041.0 8924.6 8926.6 8928.1 8963.1 8984.1 42760.4 42783.0 42870.8 42958.4 43137.0 3544.8 3605.0 3653.6 3794.9 4234.5 33012.7 33110.7 33519.3 33585.3 33691.0 4370.1 4404.5 4415.2 4446.7 4544.2 245444.0 245641.8 246535.0 246997.9 247313.0 57615.7 57866.7 57887.3 57894.0 58073.7 37000.3 38196.8 38200.4 39524.6 39745.6 17684.1 17783.8 17785.4 17789.2 17804.1 13537.9 13608.2 13608.9 13613.3 13633.7 19365.4 19562.8 19566.8 19615.5 19638.9 7129.8 7135.6 7239.3 7239.7 7279.2 937.2 938.9 1063.8 1070.5 1115.5 29659.4 29812.9 30089.2 30254.0 30393.1 1083.1 1103.9 1134.9 1137.5 1219.2 15747.6 16345.7 16406.8 16487.0 16782.7 589266.0 594227.0 595762.0 600150.0 601563.0 62069.7 62437.4 62481.4 62671.7 62707.7 1243.1 1278.1 1289.4 1400.2 1404.7 20576.3 29890.4 30466.5 32238.7 33035.5 57430.0 58069.7 58125.1 58177.1 58245.0 504922.0 506522.0 508435.0 510727.0 511007.0 29390.6 29605.6 29861.0 30397.8 30483.0 49362.5 49570.8 49946.3 50098.0 51060.0 40992.6 41742.6 41837.6 42067.0 43512.6 41241.2 41584.0 41639.4 42725.6 42899.0 27891.9 28993.7 34929.3 35134.5 36072.0 36986.8 38274.6 38515.2 39191.0 39218.8 25954.5 26006.7 26622.3 26694.0 26926.2 11:43:23 INFO - PROCESS | 9113 | 11:43:23 INFO - PROCESS | 9113 | [#2] jquery.html Cycles:180 Average:31676.46 Median:13731.43 stddev:92889.26 (676.5%) stddev-sans-first:93120.12 11:43:23 INFO - PROCESS | 9113 | Values: 381.9 384.9 388.2 403.3 417.5 13388.7 19140.3 20698.0 20717.5 20801.7 16171.4 19287.0 19838.4 19961.3 20347.8 5700.3 5859.4 5861.6 5890.5 5891.6 5523.1 5606.9 5742.3 5814.4 5816.8 5633.9 5640.2 5640.5 5642.7 5642.9 5471.5 5639.3 5645.6 5704.0 5738.0 5070.3 5104.6 5107.3 5122.7 5124.1 24204.6 24560.4 24743.8 24817.0 24920.0 2428.7 2482.7 2542.9 3081.9 3173.3 10012.4 10539.4 10554.6 10728.4 14696.6 1843.6 1894.2 1918.3 1983.7 2048.5 87250.1 87712.0 87987.1 88259.6 89185.0 10364.7 10654.9 10755.4 10987.8 11754.2 15061.1 15067.8 15074.8 15101.9 15107.8 7940.4 8277.8 8364.3 8396.3 8474.2 7988.6 8116.8 8126.9 8314.9 8315.8 4170.7 4355.3 4506.2 4610.5 4675.3 1833.3 1837.6 1903.5 1945.3 1961.1 885.8 925.9 946.5 989.0 1027.7 17870.5 18448.6 20195.8 20228.2 20326.7 977.6 998.5 1029.7 1055.6 1100.4 10694.4 11134.5 11227.6 11237.4 11365.6 530831.0 555151.0 566727.0 578668.0 584861.2 96988.0 97873.0 99570.0 100307.0 102253.5 1035.3 1065.0 1069.1 1071.8 1080.2 17018.4 17220.9 17728.2 17767.6 17777.9 44907.0 44960.3 45345.5 45643.3 46686.3 58745.4 61847.0 62786.7 63534.4 65924.0 8372.4 8497.7 8555.2 8598.7 8945.3 12994.9 13229.3 13264.0 13294.5 13685.7 10524.9 10774.4 10825.8 10907.9 11527.2 10967.7 11482.5 11503.3 11764.6 12100.9 8968.1 10664.1 11121.8 11185.3 11304.3 8507.7 8551.5 8581.2 8711.7 8758.5 9999.7 11013.5 11222.4 11281.7 11387.9 11:43:23 INFO - PROCESS | 9113 | 11:43:23 INFO - PROCESS | 9113 | [#3] mootools.html Cycles:180 Average:5909.20 Median:2522.43 stddev:3442.77 (136.5%) stddev-sans-first:3435.17 11:43:23 INFO - PROCESS | 9113 | Values: 1322.1 1455.6 1513.8 1640.3 1783.9 8535.5 8940.0 8965.7 9171.9 9177.6 8959.0 9086.7 9098.1 9100.6 9108.6 2386.7 2408.2 2413.2 2413.7 2413.9 2347.9 2400.0 2408.0 2408.0 2410.5 2327.0 2377.6 2384.9 2398.0 2402.0 2301.6 2315.7 2320.1 2322.7 2340.2 2303.8 2323.6 2332.1 2336.2 2341.1 8873.4 8969.4 9002.1 9012.4 9047.0 5267.1 5486.7 5494.5 5496.7 5498.1 3432.8 3448.3 3463.5 3485.0 3508.8 1159.1 1172.1 1185.0 1208.1 1210.8 12724.4 12772.7 12787.3 12793.6 12834.3 4413.9 4583.1 4670.4 4671.6 4703.2 10036.9 10048.3 10059.4 10061.9 10092.7 5355.1 5355.2 5363.4 5364.0 5370.8 4409.8 4776.3 4895.2 4921.4 5007.7 3861.4 3921.1 4004.7 4038.5 4041.0 1165.8 1199.5 1204.6 1216.4 1220.8 946.7 971.9 973.8 973.9 1000.2 5718.0 5888.2 5911.3 5941.5 6011.1 428.4 448.8 461.8 463.8 466.9 4074.2 4106.5 4130.3 4172.6 4174.7 11209.4 11561.2 11631.3 11639.3 11648.7 11511.8 11523.7 11524.4 11526.1 11527.3 7801.9 8084.0 8136.6 8560.7 8660.4 5795.9 5881.8 5883.8 5929.3 5966.9 10027.3 10199.1 10234.2 10648.0 10653.9 10427.1 10544.4 10704.8 10726.8 10850.1 7362.4 7683.3 7853.8 7895.4 8031.4 9011.6 9042.0 9125.7 9127.9 9138.4 7691.8 7814.5 7862.4 8052.2 8168.8 7661.3 7790.4 7866.5 7960.1 8027.2 6640.5 6705.3 6714.7 6727.2 6729.5 4999.7 5010.5 5166.0 5177.7 5521.4 5158.9 5225.4 5281.5 5290.2 5493.2 11:43:23 INFO - PROCESS | 9113 | 11:43:23 INFO - PROCESS | 9113 | [#4] prototype.html Cycles:180 Average:4562.15 Median:5176.93 stddev:1342.20 (25.9%) stddev-sans-first:1307.57 11:43:23 INFO - PROCESS | 9113 | Values: 315.5 329.3 330.2 330.3 340.2 5294.3 5316.3 5324.9 5331.8 5346.8 4935.2 5004.3 5168.7 5185.1 5290.7 4104.6 4111.8 4121.6 4124.9 4149.1 4138.4 4149.8 4164.6 4178.9 4183.3 3852.0 3874.6 4038.4 4059.2 4099.8 4006.2 4022.6 4037.7 4044.8 4048.5 3599.5 3604.8 3628.8 3633.3 3633.4 4877.9 5076.9 5088.2 5125.2 5147.3 4535.8 4537.9 4576.3 4591.1 4617.2 5374.9 5397.8 5422.7 5453.0 5471.9 3804.6 3878.4 3879.7 3896.6 3940.7 5609.8 5610.4 5644.3 5653.6 5667.2 3959.0 3968.6 3969.4 3989.9 3993.1 3945.9 4044.5 4046.4 4055.2 4061.4 4596.2 4599.8 4630.3 4649.6 4653.8 5375.9 5458.2 5459.7 5472.9 5488.6 1374.6 1376.6 1386.3 1398.3 1403.0 882.6 894.1 896.7 897.6 906.5 4738.3 4760.4 4761.5 4762.9 4773.9 4916.9 4967.8 5001.3 5029.7 5056.6 4749.0 4751.9 4929.5 5316.8 5355.6 2973.5 2974.1 2977.3 2980.6 2990.2 5719.2 5843.3 5849.6 5870.4 5887.6 5708.8 5713.7 5718.5 5724.5 5728.3 5800.6 5813.8 5828.7 5850.1 5860.9 5362.7 5539.6 5547.0 5587.0 5629.5 5477.7 5498.5 5506.8 5516.1 5523.2 5825.5 5828.3 5832.8 5838.2 5844.3 3744.9 3897.6 3950.6 3987.1 3991.0 5429.8 5504.8 5620.3 5673.0 5706.6 5453.4 5476.0 5487.3 5495.3 5496.2 5437.4 5449.9 5457.9 5483.2 5483.4 5214.3 5341.2 5351.8 5364.7 5374.0 5413.5 5462.8 5471.5 5480.6 5528.2 5212.7 5365.6 5368.3 5378.9 5422.2 11:43:23 INFO - PROCESS | 9113 | 11:43:23 INFO - PROCESS | 9113 | [#5] yui.html Cycles:180 Average:22441.48 Median:4465.08 stddev:34167.72 (765.2%) stddev-sans-first:34224.83 11:43:23 INFO - PROCESS | 9113 | Values: 771.9 813.2 852.2 869.7 881.4 15928.8 17811.5 18040.6 18052.7 18136.2 15136.0 15357.9 15368.8 15388.4 15390.0 821.7 841.3 841.5 841.6 842.4 677.1 805.0 832.9 834.4 835.5 879.1 881.5 883.3 883.5 885.6 874.0 875.2 877.1 878.2 878.4 517.4 614.4 631.4 635.8 642.4 15578.1 15655.5 15698.4 15711.2 15720.1 13848.6 14326.4 14688.8 14702.1 14851.9 11548.2 11620.8 12005.1 12212.6 12545.6 4453.8 4470.0 4485.1 4689.6 4700.0 70436.6 72618.6 74074.0 84477.2 85311.0 11330.9 11527.3 11636.9 11694.2 11930.1 21648.5 21661.2 21664.6 21678.2 21772.6 8264.5 8373.5 8620.8 8844.3 8894.0 4338.5 4460.2 4540.1 4669.5 4696.5 3524.3 3665.1 3666.4 3671.9 3673.9 622.2 624.4 624.8 636.0 636.3 663.3 669.6 678.6 701.2 711.1 8836.2 8927.4 9107.2 9300.0 9726.5 611.3 643.8 657.7 695.8 711.3 4442.3 4460.0 4506.0 4545.0 4550.3 123305.4 123340.0 131580.0 136017.0 142016.3 113674.0 115113.0 115697.4 115987.0 116452.0 90754.5 96140.0 98276.0 98359.0 101951.0 8128.8 8283.3 8347.1 8455.5 8571.5 57350.7 57849.7 58069.4 58092.4 59193.2 75055.0 87350.0 88250.6 89018.0 89694.6 11336.3 11438.4 11482.7 11519.1 11609.0 12531.3 12533.8 12674.0 12809.7 12895.7 10162.0 11512.8 11616.5 11639.7 11882.6 13290.2 13523.3 13673.9 13793.2 13999.7 12541.6 12808.4 13067.3 13685.9 13695.3 10367.9 10515.4 10736.4 10809.6 11085.2 10889.9 11194.2 11234.8 11278.6 11285.2 11:43:23 INFO - PROCESS | 9113 | -------- Summary: end -------- 11:43:23 INFO - PROCESS | 9113 | 11:43:24 INFO - TEST-INFO | 9113: exit 0 11:43:24 INFO - TEST-OK | dromaeo_css | took 1115850ms 11:43:24 INFO - TEST-START | kraken 11:43:24 INFO - operating with platform_type : linux_ 11:43:24 INFO - Initialising browser for kraken test... 11:43:24 INFO - TEST-INFO | started process 9418 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHI50E4/profile http://localhost:49551/getInfo.html) 11:43:28 INFO - PROCESS | 9418 | __metrics Screen width/height:1600/1200 11:43:28 INFO - PROCESS | 9418 | colorDepth:24 11:43:28 INFO - PROCESS | 9418 | Browser inner width/height: 1024/697 11:43:28 INFO - PROCESS | 9418 | __metrics 11:43:29 INFO - PROCESS | 9418 | 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" 11:43:29 INFO - PROCESS | 9418 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:43:29 INFO - PROCESS | 9418 | console.error: PushService: 11:43:29 INFO - PROCESS | 9418 | stateChangeProcessEnqueue: Error transitioning state 11:43:29 INFO - PROCESS | 9418 | UnknownError 11:43:30 INFO - TEST-INFO | 9418: exit 0 11:43:30 INFO - Browser initialized. 11:43:30 INFO - Running cycle 1/1 for kraken test... 11:43:30 INFO - TEST-INFO | started process 9497 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHI50E4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:43:42 INFO - PROCESS | 9497 | RSS: Main: 156770304 11:43:42 INFO - PROCESS | 9497 | 11:43:44 INFO - PROCESS | 9497 | Cycle 1(1): loaded http://localhost:49551/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49551/tests/kraken/driver.html?testName=audio-beat-detection) 11:43:45 INFO - PROCESS | 9497 | RSS: Main: 213233664 11:43:45 INFO - PROCESS | 9497 | 11:43:48 INFO - PROCESS | 9497 | Cycle 1(1): loaded http://localhost:49551/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49551/tests/kraken/driver.html?testName=audio-dft) 11:43:48 INFO - PROCESS | 9497 | RSS: Main: 192471040 11:43:48 INFO - PROCESS | 9497 | 11:43:51 INFO - PROCESS | 9497 | Cycle 1(1): loaded http://localhost:49551/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49551/tests/kraken/driver.html?testName=audio-fft) 11:43:52 INFO - PROCESS | 9497 | RSS: Main: 269627392 11:43:52 INFO - PROCESS | 9497 | 11:43:54 INFO - PROCESS | 9497 | Cycle 1(1): loaded http://localhost:49551/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49551/tests/kraken/driver.html?testName=audio-oscillator) 11:43:55 INFO - PROCESS | 9497 | RSS: Main: 180260864 11:43:55 INFO - PROCESS | 9497 | 11:43:57 INFO - PROCESS | 9497 | Cycle 1(1): loaded http://localhost:49551/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49551/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:43:57 INFO - PROCESS | 9497 | RSS: Main: 184946688 11:43:57 INFO - PROCESS | 9497 | 11:44:00 INFO - PROCESS | 9497 | Cycle 1(1): loaded http://localhost:49551/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49551/tests/kraken/driver.html?testName=imaging-darkroom) 11:44:01 INFO - PROCESS | 9497 | RSS: Main: 219406336 11:44:01 INFO - PROCESS | 9497 | 11:44:04 INFO - PROCESS | 9497 | Cycle 1(1): loaded http://localhost:49551/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49551/tests/kraken/driver.html?testName=imaging-desaturate) 11:44:05 INFO - PROCESS | 9497 | RSS: Main: 220700672 11:44:05 INFO - PROCESS | 9497 | 11:44:08 INFO - PROCESS | 9497 | Cycle 1(1): loaded http://localhost:49551/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49551/tests/kraken/driver.html?testName=json-parse-financial) 11:44:08 INFO - PROCESS | 9497 | RSS: Main: 220442624 11:44:08 INFO - PROCESS | 9497 | 11:44:10 INFO - PROCESS | 9497 | Cycle 1(1): loaded http://localhost:49551/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49551/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:44:10 INFO - PROCESS | 9497 | RSS: Main: 184127488 11:44:10 INFO - PROCESS | 9497 | 11:44:12 INFO - PROCESS | 9497 | Cycle 1(1): loaded http://localhost:49551/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49551/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:44:13 INFO - PROCESS | 9497 | RSS: Main: 189554688 11:44:13 INFO - PROCESS | 9497 | 11:44:15 INFO - PROCESS | 9497 | Cycle 1(1): loaded http://localhost:49551/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49551/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:44:15 INFO - PROCESS | 9497 | RSS: Main: 194088960 11:44:15 INFO - PROCESS | 9497 | 11:44:18 INFO - PROCESS | 9497 | Cycle 1(1): loaded http://localhost:49551/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49551/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:44:19 INFO - PROCESS | 9497 | RSS: Main: 193810432 11:44:19 INFO - PROCESS | 9497 | 11:44:21 INFO - PROCESS | 9497 | Cycle 1(1): loaded http://localhost:49551/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49551/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:44:22 INFO - PROCESS | 9497 | RSS: Main: 196308992 11:44:22 INFO - PROCESS | 9497 | 11:44:24 INFO - PROCESS | 9497 | Cycle 1(1): loaded http://localhost:49551/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49551/tests/kraken/driver.html?testName=ai-astar) 11:44:24 INFO - PROCESS | 9497 | RSS: Main: 244379648 11:44:24 INFO - PROCESS | 9497 | 11:44:24 INFO - PROCESS | 9497 | __start_tp_report 11:44:24 INFO - PROCESS | 9497 | _x_x_mozilla_page_load 11:44:24 INFO - PROCESS | 9497 | _x_x_mozilla_page_load_details 11:44:24 INFO - PROCESS | 9497 | |i|pagename|runs| 11:44:24 INFO - PROCESS | 9497 | |0;ai-astar;102;111;111;111;113;114;110;112;110;110 11:44:24 INFO - PROCESS | 9497 | |1;audio-beat-detection;144;116;119;173;119;126;144;118;150;118 11:44:24 INFO - PROCESS | 9497 | |2;audio-dft;167;159;160;161;160;160;159;160;160;160 11:44:24 INFO - PROCESS | 9497 | |3;audio-fft;74;75;76;132;75;76;75;74;108;73 11:44:24 INFO - PROCESS | 9497 | |4;audio-oscillator;83;83;120;82;83;84;122;84;84;130 11:44:24 INFO - PROCESS | 9497 | |5;imaging-gaussian-blur;118;116;117;117;116;117;116;116;117;117 11:44:24 INFO - PROCESS | 9497 | |6;imaging-darkroom;146;146;147;147;146;146;147;146;146;146 11:44:24 INFO - PROCESS | 9497 | |7;imaging-desaturate;95;95;95;95;95;95;96;95;96;95 11:44:24 INFO - PROCESS | 9497 | |8;json-parse-financial;50;48;48;49;49;50;49;49;48;49 11:44:24 INFO - PROCESS | 9497 | |9;json-stringify-tinderbox;61;61;61;60;61;62;61;61;62;61 11:44:24 INFO - PROCESS | 9497 | |10;stanford-crypto-aes;75;75;75;76;84;78;85;76;74;77 11:44:24 INFO - PROCESS | 9497 | |11;stanford-crypto-ccm;118;134;119;120;127;131;118;129;197;136 11:44:24 INFO - PROCESS | 9497 | |12;stanford-crypto-pbkdf2;159;160;155;156;155;159;156;157;159;159 11:44:24 INFO - PROCESS | 9497 | |13;stanford-crypto-sha256-iterative;62;61;62;62;62;62;62;62;60;61 11:44:24 INFO - PROCESS | 9497 | __end_tp_report 11:44:24 INFO - PROCESS | 9497 | __start_cc_report 11:44:24 INFO - PROCESS | 9497 | _x_x_mozilla_cycle_collect,1634 11:44:24 INFO - PROCESS | 9497 | __end_cc_report 11:44:24 INFO - PROCESS | 9497 | __startTimestamp1470422664310__endTimestamp 11:44:24 INFO - PROCESS | 9497 | 11:44:24 INFO - PROCESS | 9497 | ------- Summary: start ------- 11:44:24 INFO - PROCESS | 9497 | Number of tests: 14 11:44:24 INFO - PROCESS | 9497 | 11:44:24 INFO - PROCESS | 9497 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:3.24 (2.9%) stddev-sans-first:1.41 11:44:24 INFO - PROCESS | 9497 | Values: 102.0 111.0 111.0 111.0 113.0 114.0 110.0 112.0 110.0 110.0 11:44:24 INFO - PROCESS | 9497 | 11:44:24 INFO - PROCESS | 9497 | [#1] audio-beat-detection Cycles:10 Average:132.70 Median:135.00 stddev:19.18 (14.2%) stddev-sans-first:19.90 11:44:24 INFO - PROCESS | 9497 | Values: 144.0 116.0 119.0 173.0 119.0 126.0 144.0 118.0 150.0 118.0 11:44:24 INFO - PROCESS | 9497 | 11:44:24 INFO - PROCESS | 9497 | [#2] audio-dft Cycles:10 Average:160.60 Median:160.00 stddev:2.32 (1.4%) stddev-sans-first:0.60 11:44:24 INFO - PROCESS | 9497 | Values: 167.0 159.0 160.0 161.0 160.0 160.0 159.0 160.0 160.0 160.0 11:44:24 INFO - PROCESS | 9497 | 11:44:24 INFO - PROCESS | 9497 | [#3] audio-fft Cycles:10 Average:83.80 Median:75.00 stddev:19.92 (26.6%) stddev-sans-first:20.81 11:44:24 INFO - PROCESS | 9497 | Values: 74.0 75.0 76.0 132.0 75.0 76.0 75.0 74.0 108.0 73.0 11:44:24 INFO - PROCESS | 9497 | 11:44:24 INFO - PROCESS | 9497 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:83.00 stddev:19.83 (23.9%) stddev-sans-first:20.51 11:44:24 INFO - PROCESS | 9497 | Values: 83.0 83.0 120.0 82.0 83.0 84.0 122.0 84.0 84.0 130.0 11:44:24 INFO - PROCESS | 9497 | 11:44:24 INFO - PROCESS | 9497 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.53 11:44:24 INFO - PROCESS | 9497 | Values: 118.0 116.0 117.0 117.0 116.0 117.0 116.0 116.0 117.0 117.0 11:44:24 INFO - PROCESS | 9497 | 11:44:24 INFO - PROCESS | 9497 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 11:44:24 INFO - PROCESS | 9497 | Values: 146.0 146.0 147.0 147.0 146.0 146.0 147.0 146.0 146.0 146.0 11:44:24 INFO - PROCESS | 9497 | 11:44:24 INFO - PROCESS | 9497 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:44:24 INFO - PROCESS | 9497 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 11:44:24 INFO - PROCESS | 9497 | 11:44:24 INFO - PROCESS | 9497 | [#8] json-parse-financial Cycles:10 Average:48.90 Median:49.00 stddev:0.74 (1.5%) stddev-sans-first:0.67 11:44:24 INFO - PROCESS | 9497 | Values: 50.0 48.0 48.0 49.0 49.0 50.0 49.0 49.0 48.0 49.0 11:44:24 INFO - PROCESS | 9497 | 11:44:24 INFO - PROCESS | 9497 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:61.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 11:44:24 INFO - PROCESS | 9497 | Values: 61.0 61.0 61.0 60.0 61.0 62.0 61.0 61.0 62.0 61.0 11:44:24 INFO - PROCESS | 9497 | 11:44:24 INFO - PROCESS | 9497 | [#10] stanford-crypto-aes Cycles:10 Average:77.50 Median:76.50 stddev:3.87 (5.1%) stddev-sans-first:3.99 11:44:24 INFO - PROCESS | 9497 | Values: 75.0 75.0 75.0 76.0 84.0 78.0 85.0 76.0 74.0 77.0 11:44:24 INFO - PROCESS | 9497 | 11:44:24 INFO - PROCESS | 9497 | [#11] stanford-crypto-ccm Cycles:10 Average:132.90 Median:130.00 stddev:23.52 (18.1%) stddev-sans-first:24.32 11:44:24 INFO - PROCESS | 9497 | Values: 118.0 134.0 119.0 120.0 127.0 131.0 118.0 129.0 197.0 136.0 11:44:24 INFO - PROCESS | 9497 | 11:44:24 INFO - PROCESS | 9497 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.50 Median:159.00 stddev:1.90 (1.2%) stddev-sans-first:1.94 11:44:24 INFO - PROCESS | 9497 | Values: 159.0 160.0 155.0 156.0 155.0 159.0 156.0 157.0 159.0 159.0 11:44:24 INFO - PROCESS | 9497 | 11:44:24 INFO - PROCESS | 9497 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.60 Median:62.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 11:44:24 INFO - PROCESS | 9497 | Values: 62.0 61.0 62.0 62.0 62.0 62.0 62.0 62.0 60.0 61.0 11:44:24 INFO - PROCESS | 9497 | -------- Summary: end -------- 11:44:24 INFO - PROCESS | 9497 | 11:44:25 INFO - TEST-INFO | 9497: exit 0 11:44:25 INFO - TEST-OK | kraken | took 61007ms 11:44:25 INFO - SUITE-END | took 1176s 11:44:25 INFO - Completed test suite (00:19:36) 11:44:25 INFO - javascript benchmark 11:44:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3027.1523973287485, 3036.1498780341503, 3047.0706434537465, 3067.432524982877, 3082.9075127746178, 5185.429602743695, 5208.036513245052, 5214.165733482639, 5312.150055991042, 5324.201369794528, 5267.446918073595, 5271.894562108756, 5315.920261196075, 5337.5196232339085, 5344.465553444654, 4760.404949381336, 4791.784369703354, 4829.420469543659, 4835.516448355172, 4975.4527002029745, 4880.731559764212, 4895.388076490439, 4923.82766603169, 4942.6293028022865, 4948.57937075349, 4757.0723708876785, 4765.976170119127, 4801.567858892681, 4826.083044221622, 4873.0, 4758.547937945889, 4759.976200118977, 4782.187028205213, 4893.1926232171645, 4924.778384972685, 4760.833370832039, 4793.3768610080815, 4803.063402636487, 4846.030793841211, 4864.902701945941, 5121.82073627425, 5187.299714538527, 5226.320578324831, 5253.842384728464, 5282.3925248596515, 5601.831945041656, 5635.520980716644, 5639.915401268984, 5693.572982026365, 5695.971520142372, 5662.2639056922335, 5720.856978575527, 5729.255196824386, 5730.111832665943, 5732.226149469851, 5105.310783044241, 5203.817866374735, 5241.266222728821, 5283.762230699589, 5330.520253177233, 5789.623674461231, 5805.100209467455, 5830.329512106077, 5851.1515830205235, 5851.32709738377, 5574.498295153375, 5616.0, 5625.353084395265, 5630.690312032878, 5632.633878797865, 5464.672119672832, 5522.061249587579, 5565.1374037024325, 5641.80253691127, 5691.9146212806845, 5588.860278492989, 5592.384837667853, 5594.3286805582775, 5619.100943848965, 5642.6614403135945, 5547.583931205095, 5583.302087239095, 5583.944160558342, 5594.664320140804, 5605.747741351649, 4241.172971270635, 4292.077203401283, 4319.784010799447, 4324.005478739908, 4362.1493808707, 3864.9033774155873, 3886.1644746379666, 3900.6684431823614, 3902.200048990007, 3947.842086316515, 5329.7068661224, 5334.893302133935, 5336.226247194135, 5342.626016178908, 5344.706041167773, 5516.503514683698, 5596.27248457706, 5644.322681278273, 5650.29371328584, 5650.5479561634975, 5320.467953204648, 5344.25180474726, 5346.625736198506, 5350.224217488442, 5374.220737992969, 4811.807527698853, 4811.807527698923, 4815.638827087912, 4822.590079843252, 4861.975690121527, 5743.224664670383, 5800.883982320245, 5886.381929897385, 5899.67551784656, 5901.085331773496, 5607.719614019365, 5637.323521177321, 5649.435056494318, 5679.829605111853, 5695.743691533974, 5861.062230043172, 5875.383084776208, 5876.853078672896, 5880.14737863016, 5882.382349853204, 5459.181122831607, 5482.095454250004, 5529.529989950738, 5544.0575102231915, 5553.111502159635, 5622.100463925753, 5665.20687103814, 5668.659880407189, 5720.313562372542, 5723.370429252862, 5480.123180291134, 5495.560355171657, 5504.339479262514, 5541.833744987657, 5544.889102218014, 5423.457654234703, 5449.373322067854, 5458.153986132156, 5492.5331346835965, 5552.444755524415, 5419.756110974937, 5453.2365468833605, 5460.3993560707495, 5507.146392309199, 5508.256385387921, 5580.972095139661, 5589.776408943597, 5629.380768115586, 5636.154576813511, 5639.351474580311, 5333.466653334635, 5392.892142157057, 5446.836594902159, 5463.043967305626, 5465.617406781487], "value": 5209.505457160041, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.7459152568587, 582.4990508162982, 584.9532037437006, 598.2312728144335, 614.2138063279002, 33315.33369332615, 33943.0, 44703.77648111759, 45383.09233815322, 45480.0, 46180.76909615447, 46772.298415523794, 46831.53168468314, 46840.76579617106, 46879.06241875161, 8910.866337004934, 9048.547572621343, 9052.773680658003, 9059.184673379394, 9065.04816994216, 8915.910840891573, 9000.549972501349, 9001.774955626097, 9024.278057755397, 9024.729258122266, 9067.36528443006, 9094.181523662868, 9096.090390960917, 9100.8634870477, 9102.271818254558, 8980.64077436905, 9024.05247449015, 9024.323175761778, 9033.05152958943, 9040.954795226047, 8924.55377231136, 8926.553672316359, 8928.062553431926, 8963.10368963105, 8984.146506081977, 42760.3585946211, 42783.0, 42870.78564607188, 42958.35562466565, 43137.0, 3544.805035723034, 3604.9906026312674, 3653.561572611277, 3794.90512737181, 4234.470691163605, 33012.6698733012, 33110.668893311, 33519.32961340759, 33585.32829343424, 33691.0, 4370.104128653618, 4404.4934832494355, 4415.161119387306, 4446.73319600825, 4544.182047231497, 245444.0, 245641.77179114168, 246535.0, 246997.88509517114, 247313.0, 57615.711921440125, 57866.71066644724, 57887.263382097764, 57894.0, 58073.70963145242, 37000.259994799955, 38196.80901595474, 38200.426993595116, 39524.60475395267, 39745.60254397477, 17684.115794210236, 17783.822161778477, 17785.377511787025, 17789.19948602316, 17804.109794510223, 13537.932310338385, 13608.183508989492, 13608.86391136076, 13613.251271180181, 13633.727325453634, 19365.355465546578, 19562.804371956383, 19566.78051411116, 19615.509612259808, 19638.91985940787, 7129.7861064168155, 7135.643217839087, 7239.334952960849, 7239.746608868664, 7279.162896266891, 937.2408349237139, 938.9154976052188, 1063.8351055586397, 1070.5289672544056, 1115.4980258883536, 29659.406811864075, 29812.850935745617, 30089.247768805955, 30254.0, 30393.088207353816, 1083.1389045708681, 1103.8840921703265, 1134.8581427321585, 1137.4767606900753, 1219.1587804414926, 15747.606309842346, 16345.673086538203, 16406.83593164077, 16487.0, 16782.74825877613, 589266.0, 594227.0, 595762.0, 600150.0, 601563.0, 62069.68965155145, 62437.375626244066, 62481.375186248464, 62671.686641567416, 62707.6864615674, 1243.12980913361, 1278.0733967873218, 1289.374653293171, 1400.1669006940854, 1404.6909679870412, 20576.279830205873, 29890.402191956473, 30466.543001854545, 32238.677613224507, 33035.504467432525, 57430.0, 58069.70965145147, 58125.128123079034, 58177.12734308904, 58245.0, 504922.0, 506522.0, 508435.0, 510727.0, 511007.0, 29390.559141612466, 29605.555916660836, 29861.0, 30397.84801076069, 30483.037205163186, 49362.506374935794, 49570.752146239036, 49946.25080623721, 50097.998040039725, 51060.0, 40992.59007410007, 41742.582574173866, 41837.58162418337, 42067.0, 43512.56487435085, 41241.1751764957, 41584.0, 41639.37540936949, 42725.572744273406, 42899.0, 27891.860540697166, 28993.7100628991, 34929.30141397107, 35134.472982904765, 36072.0, 36986.8150659245, 38274.617253827106, 38515.229695405375, 39191.0, 39218.80390598029, 25954.480910382063, 26006.73993260043, 26622.334441639116, 26694.0, 26926.192214233604], "value": 19958.075410746704, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.8548951398468, 384.93840985442324, 388.1906225519791, 403.27209387056365, 417.5135966598912, 13388.741444335797, 19140.330088446906, 20698.0, 20717.482062948417, 20801.687974680393, 16171.35314587418, 19287.0, 19838.40484785459, 19961.301354452597, 20347.796522034776, 5700.315962084555, 5859.417957151567, 5861.5603829712945, 5890.469857712805, 5891.558133140032, 5523.143912693539, 5606.943930560683, 5742.253507044078, 5814.389489103647, 5816.796412125576, 5633.859153521174, 5640.210370548127, 5640.520555752766, 5642.689652069134, 5642.943570564304, 5471.480209380103, 5639.323281206261, 5645.604807663465, 5703.971480142614, 5738.0, 5070.31550740649, 5104.566111880495, 5107.3105130807235, 5122.692638441706, 5124.0776660201145, 24204.636930446057, 24560.385990350205, 24743.752562474503, 24817.0, 24920.0, 2428.7034001847624, 2482.6524286599893, 2542.8601426921514, 3081.876724931, 3173.2701478659806, 10012.399256044588, 10539.367637941748, 10554.630587929385, 10728.409937453436, 14696.632584185374, 1843.5575461889184, 1894.1760334254507, 1918.3285849952545, 1983.6925276582153, 2048.4673984764067, 87250.12749872483, 87712.0, 87987.12012879853, 88259.55870220672, 89185.0, 10364.740881478023, 10654.869026194792, 10755.40845253503, 10987.83518247211, 11754.177207595387, 15061.096334219981, 15067.773983390258, 15074.773878391832, 15101.924490377478, 15107.773383399257, 7940.444168908237, 8277.793055173548, 8364.330853531703, 8396.286315663116, 8474.194951479723, 7988.640511177011, 8116.75649730509, 8126.918730812735, 8314.875276870851, 8315.8336833263, 4170.666346692257, 4355.2813785725, 4506.233940230103, 4610.515895830957, 4675.345451636774, 1833.2575307000686, 1837.5773572078497, 1903.45751460833, 1945.309415157627, 1961.1469010979984, 885.7918389178537, 925.9444433334022, 946.5267366316841, 988.9764094162507, 1027.6557353286582, 17870.46388608344, 18448.631027379644, 20195.798042019687, 20228.19087236494, 20326.695099573517, 977.6431602465049, 998.5356809083665, 1029.6602121299952, 1055.6199768083484, 1100.3782862682558, 10694.358338499715, 11134.49894754738, 11227.55089796399, 11237.38194399316, 11365.602203922823, 530831.0, 555151.0, 566727.0, 578668.0, 584861.2111031107, 96988.0, 97873.0, 99570.0, 100307.0, 102253.48873255587, 1035.3115178406426, 1064.9680509584725, 1069.053887309721, 1071.7802850415646, 1080.2114456446996, 17018.404355847484, 17220.913895430946, 17728.202230899897, 17767.64464710673, 17777.911110444365, 44907.0, 44960.32559511675, 45345.54654453413, 45643.31535027044, 46686.299705505124, 58745.412545875704, 61847.0, 62786.686066569375, 63534.364656352845, 65924.0, 8372.372072094495, 8497.702580409656, 8555.187257210555, 8598.742037738877, 8945.284377249674, 12994.870051299366, 13229.272390018641, 13264.0, 13294.468221271427, 13685.726285474433, 10524.94737526338, 10774.353538787698, 10825.783484330112, 10907.890921090688, 11527.193096483501, 10967.670969870916, 11482.540698371971, 11503.257524281438, 11764.647060588197, 12100.939495302819, 8968.10318968124, 10664.146868250366, 11121.777564448505, 11185.32888026721, 11304.265222760494, 8507.702230421906, 8551.486910785372, 8581.155051663922, 8711.738647840575, 8758.47449153053, 9999.700008999742, 11013.504392302206, 11222.438878055902, 11281.661550153509, 11387.886121138683], "value": 9347.350815974212, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1322.10097133949, 1455.6288146522636, 1513.8410466900975, 1640.2864753832077, 1783.8572914166868, 8535.530545819978, 8940.0, 8965.686200982975, 9171.862422063658, 9177.632894684204, 8958.955205223965, 9086.681966131187, 9098.13567711068, 9100.635974561026, 9108.635654573809, 2386.7255265644458, 2408.157144999254, 2413.1915808204185, 2413.662087307778, 2413.9034438622434, 2347.9413014674683, 2400.0, 2407.987960060197, 2408.0488207158164, 2410.4576470294132, 2326.9528712079546, 2377.5720370333333, 2384.904603815854, 2397.9520409591796, 2402.0, 2301.5627030864084, 2315.722113346401, 2320.0835669910375, 2322.698049253603, 2340.157543284416, 2303.8272129590346, 2323.581755284048, 2332.1137967572213, 2336.158982766203, 2341.0518739910362, 8873.423227490193, 8969.372143949926, 9002.05478424769, 9012.369134160612, 9047.0, 5267.130923397634, 5486.698231597261, 5494.5054945054735, 5496.697681627509, 5498.147787093007, 3432.7940323580665, 3448.3103379323984, 3463.4977928200524, 3485.0, 3508.7894726316504, 1159.0611604600301, 1172.144334635712, 1184.9585264515702, 1208.0758219961735, 1210.7699537088013, 12724.363781810873, 12772.744545109139, 12787.296698681568, 12793.55222567215, 12834.294113823737, 4413.867583972486, 4583.083383323348, 4670.439547254351, 4671.649626278043, 4703.153432382204, 10036.899631003596, 10048.346857454242, 10059.39643621385, 10061.949690251502, 10092.747681308027, 5355.0896347621, 5355.196720491879, 5363.356397232357, 5364.034473794676, 5370.812021579304, 4409.757463339483, 4776.307435421844, 4895.216765317603, 4921.409430868319, 5007.69953802773, 3861.362875125629, 3921.117748506563, 4004.699647526389, 4038.51537815464, 4040.959590404117, 1165.8367828504017, 1199.4542483170312, 1204.5904392506416, 1216.4282787090053, 1220.8219068598844, 946.6875930942772, 971.917387022111, 973.7711637765119, 973.8587904753771, 1000.2398177385094, 5717.971410143005, 5888.175655408247, 5911.3201981772645, 5941.494972927263, 6011.09833524966, 428.39565825981276, 448.83841816945875, 461.7737308718704, 463.8237469761469, 466.855274864793, 4074.2258970795456, 4106.466159399319, 4130.297849365615, 4172.645325147397, 4174.7077704561, 11209.383483908463, 11561.248518846249, 11631.302121872546, 11639.301641901513, 11648.650540483799, 11511.769764604662, 11523.654290371302, 11524.423778811026, 11526.077913766878, 11527.308361498337, 7801.882971755428, 8084.029916410069, 8136.593170341577, 8560.743177704679, 8660.350473714496, 5795.913061304, 5881.794137205177, 5883.764649413975, 5929.318128415288, 5966.850828729316, 10027.348222365523, 10199.0820826126, 10234.232432567736, 10648.041676249175, 10653.89346106529, 10427.113695335982, 10544.367337959748, 10704.785904282027, 10726.785464290826, 10850.131989440984, 7362.3741981932135, 7683.34691551202, 7853.803654908673, 7895.368370530458, 8031.397645176752, 9011.594478248626, 9042.0, 9125.726228213165, 9127.863082053642, 9138.360314777901, 7691.807704807425, 7814.492058016211, 7862.449628526177, 8052.15452377492, 8168.847379911351, 7661.272179142972, 7790.376769858511, 7866.488678235896, 7960.124386317616, 8027.1972802719265, 6640.535162538769, 6705.262421133769, 6714.697838597177, 6727.192736871607, 6729.528932974645, 4999.725015124203, 5010.473900240568, 5166.0, 5177.689338639693, 5521.365043019943, 5158.8968220636125, 5225.425203227718, 5281.524662780214, 5290.153575427913, 5493.203485494501], "value": 4619.85104176282, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.5424634280294, 329.2706654759707, 330.17291684330746, 330.33767296570375, 340.15980528095594, 5294.311739473867, 5316.308879845625, 5324.896665817, 5331.840044798652, 5346.839594812152, 4935.235038569019, 5004.349434573501, 5168.715720635363, 5185.144451165563, 5290.656107353019, 4104.56902025286, 4111.773852438115, 4121.5878412158845, 4124.896877578055, 4149.087200815816, 4138.420621113047, 4149.751014939114, 4164.6464898907825, 4178.913482494543, 4183.309753890604, 3851.9792255052434, 3874.5544262409903, 4038.4144299076615, 4059.2287465381633, 4099.815508302118, 4006.2187873364705, 4022.5776293489203, 4037.7375470594316, 4044.757314561136, 4048.5344185418758, 3599.4960705501253, 3604.8197590120653, 3628.8004159771203, 3633.291508155911, 3633.418653015531, 4877.853664390039, 5076.873078173038, 5088.211327244283, 5125.2312153176945, 5147.3051138096625, 4535.750533720644, 4537.931931021038, 4576.26779715244, 4591.127685739699, 4617.153138744496, 5374.8925021499745, 5397.78408863645, 5422.674639521601, 5452.972735136339, 5471.917921231185, 3804.5814960354337, 3878.3600705883778, 3879.7478163919254, 3896.5908579599018, 3940.7438516496622, 5609.803656872031, 5610.410906854762, 5644.322681278232, 5653.604247702662, 5667.178259152441, 3958.960410395859, 3968.583298753647, 3969.4244334571904, 3989.92020159601, 3993.121513267077, 3945.9013524662114, 4044.5348784890116, 4046.433499310099, 4055.2497787909333, 4061.3704875744306, 4596.2416201326405, 4599.793009314589, 4630.305454181899, 4649.558291962258, 4653.767311634405, 5375.892482150335, 5458.181272809031, 5459.727013649302, 5472.863178420492, 5488.615796894179, 1374.6046766441677, 1376.6076668149528, 1386.2860626777217, 1398.2519352146553, 1402.9649258768409, 882.5807741322949, 894.1134206823597, 896.7444278380631, 897.6454300551246, 906.4787747045475, 4738.265568836836, 4760.381150450419, 4761.547652972962, 4762.880927976759, 4773.880652983703, 4916.877078073006, 4967.751612419364, 5001.349824522788, 5029.699606836102, 5056.595472362203, 4749.0, 4751.857444276678, 4929.482404347564, 5316.813911513156, 5355.598330125256, 2973.539101439237, 2974.0668565432643, 2977.3003344214094, 2980.6274215723033, 2990.20759498733, 5719.19931209631, 5843.305441422025, 5849.61977471463, 5870.417016512721, 5887.587868849225, 5708.80019199326, 5713.657180569179, 5718.456746609066, 5724.4561766632105, 5728.283964504437, 5800.5939584229545, 5813.761701744774, 5828.708564571754, 5850.0932355484965, 5860.882782344244, 5362.731863406892, 5539.556835453234, 5547.0, 5586.972065139648, 5629.4652008059165, 5477.67133971963, 5498.505134537911, 5506.834794956158, 5516.14499752539, 5523.1991361253195, 5825.475707186373, 5828.271466066742, 5832.825015249549, 5838.211841401527, 5844.298684157929, 3744.925101498009, 3897.610238976193, 3950.6049395060263, 3987.12605075614, 3991.0, 5429.755660995185, 5504.80733174337, 5620.297462817148, 5672.9505041567445, 5706.600537962303, 5453.372862120748, 5476.0, 5487.341519017744, 5495.313085864267, 5496.230527726201, 5437.374701909331, 5449.918251226156, 5457.945420545744, 5483.232347471437, 5483.369412517612, 5214.2960700304975, 5341.172118321666, 5351.759170837244, 5364.678119312854, 5374.0, 5413.53984911287, 5462.781488740406, 5471.480209380262, 5480.561555075505, 5528.170774383874, 5212.739363031909, 5365.631763900181, 5368.302120724281, 5378.919316210338, 5422.213779001943], "value": 4134.5136678939325, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [771.9134623493752, 813.1665043330589, 852.2159613155897, 869.6564856881532, 881.4314766975299, 15928.84071159288, 17811.46565603034, 18040.63918721625, 18052.729209061876, 18136.183871725756, 15136.0, 15357.923210383933, 15368.846311536881, 15388.384464621402, 15390.0, 821.6549049399266, 841.3437518735396, 841.4698739793921, 841.6296829395077, 842.4397775479299, 677.0893148714971, 804.9758507244792, 832.9416940814145, 834.4242472693852, 835.4736515994915, 879.1077056787366, 881.5019513974615, 883.2977782662766, 883.5405589093667, 885.5749240364629, 873.9825203495958, 875.1948207648978, 877.1053525404116, 878.1876763993345, 878.3763527895202, 517.3791450259704, 614.4070971512512, 631.4190944331226, 635.7870113511979, 642.418611156899, 15578.143202123878, 15655.452059177987, 15698.37206511738, 15711.21443927799, 15720.056796592242, 13848.584542463743, 14326.426942922271, 14688.779668304984, 14702.117872927658, 14851.851481485155, 11548.191626586142, 11620.767584648343, 12005.09961752872, 12212.633620991295, 12545.56090536836, 4453.844115455976, 4470.0, 4485.1254005468945, 4689.648276379251, 4700.0, 70436.64781676058, 72618.63690681513, 74074.0, 84477.15522844755, 85311.0, 11330.886691133148, 11527.250728702607, 11636.94181529087, 11694.239874408137, 11930.105242106876, 21648.458788530414, 21661.241856534947, 21664.566708665738, 21678.24126155577, 21772.56454870894, 8264.504129752235, 8373.539455329894, 8620.827583448296, 8844.292456603456, 8893.955530222436, 4338.501072376654, 4460.1525710114975, 4540.137373898949, 4669.533046695304, 4696.459907110658, 3524.2775231077567, 3665.0654083209142, 3666.358387282215, 3671.9265614687556, 3673.8530458781884, 622.1911515030442, 624.406813527151, 624.8000639795313, 636.0395802338502, 636.3254949753184, 663.2538394306405, 669.608279156689, 678.5589366911448, 701.1971292869636, 711.1466240511407, 8836.204741573289, 8927.395045215893, 9107.18035376806, 9299.95350023259, 9726.513674316397, 611.2878496551468, 643.8422586466346, 657.7204688007578, 695.7564852301654, 711.3135823929932, 4442.311441726538, 4459.989085677406, 4505.954940450553, 4545.0, 4550.251906724764, 123305.38347308207, 123340.0, 131580.0, 136017.0, 142016.2899185518, 113674.0, 115113.0, 115697.4215128919, 115987.0, 116452.0, 90754.54622726844, 96140.0, 98276.0, 98359.0, 101950.99999999852, 8128.796780080545, 8283.25450709439, 8347.081820999563, 8455.450395724258, 8571.513783813469, 57350.7132464335, 57849.71075144597, 58069.419305806405, 58092.4190758087, 59193.19278283053, 75055.0, 87350.0, 88250.55874720842, 89018.0, 89694.55152724456, 11336.263142895685, 11438.370889601152, 11482.655520334403, 11519.078473721915, 11609.0, 12531.310777907303, 12533.811992820298, 12673.953293914035, 12809.743805124031, 12895.742085158057, 10162.0, 11512.769744605228, 11616.535338586362, 11639.6508104757, 11882.643520694393, 13290.20258784476, 13523.323833808074, 13673.863261367656, 13793.172409655454, 13999.650008749863, 12541.623751287476, 12808.359582020676, 13067.281299528617, 13685.931570342085, 13695.315234238447, 10367.94816025915, 10515.369077855354, 10736.409497477402, 10809.56761729522, 11085.224034317844, 10889.945550272198, 11194.160437967023, 11234.775304494027, 11278.605248816251, 11285.153613478858], "value": 7645.674915678362, "unit": "score"}], "name": "dromaeo_css", "value": 7222.48134324283, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 111.0, 111.0, 113.0, 114.0, 110.0, 112.0, 110.0, 110.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 116.0, 119.0, 173.0, 119.0, 126.0, 144.0, 118.0, 150.0, 118.0], "value": 132.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 159.0, 160.0, 161.0, 160.0, 160.0, 159.0, 160.0, 160.0, 160.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 132.0, 75.0, 76.0, 75.0, 74.0, 108.0, 73.0], "value": 83.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 120.0, 82.0, 83.0, 84.0, 122.0, 84.0, 84.0, 130.0], "value": 95.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 48.0, 48.0, 49.0, 49.0, 50.0, 49.0, 49.0, 48.0, 49.0], "value": 48.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 60.0, 61.0, 62.0, 61.0, 61.0, 62.0, 61.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 76.0, 84.0, 78.0, 85.0, 76.0, 74.0, 77.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 134.0, 119.0, 120.0, 127.0, 131.0, 118.0, 129.0, 197.0, 136.0], "value": 132.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 155.0, 156.0, 155.0, 159.0, 156.0, 157.0, 159.0, 159.0], "value": 157.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 60.0, 61.0], "value": 61.6, "unit": "score"}], "name": "kraken", "value": 1480.7, "alertThreshold": 2.0}]} 11:44:25 INFO - Return code: 0 11:44:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:44:25 INFO - # TBPL SUCCESS # 11:44:25 INFO - Running post-action listener: _resource_record_post_action 11:44:25 INFO - [mozharness: 2016-08-05 18:44:25.601333Z] Finished run-tests step (success) 11:44:25 INFO - Running post-run listener: _resource_record_post_run 11:44:25 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 339968; Write bytes: 409325568; Read time: 88; Write time: 297944 11:44:25 INFO - TinderboxPrint: CPU usage
13.0% 11:44:25 INFO - TinderboxPrint: I/O read bytes / time
339,968 / 88 11:44:25 INFO - TinderboxPrint: I/O write bytes / time
409,325,568 / 297,944 11:44:25 INFO - TinderboxPrint: CPU idle
8,289.7 (87.0%) 11:44:25 INFO - TinderboxPrint: CPU user
1,196.9 (12.6%) 11:44:25 INFO - TinderboxPrint: Swap in / out
0 / 0 11:44:25 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 117751808; Read time: 0; Write time: 78996 11:44:25 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 335872; Write bytes: 291573760; Read time: 72; Write time: 218948 11:44:26 INFO - Running post-run listener: _upload_blobber_files 11:44:26 INFO - Blob upload gear active. 11:44:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:44:26 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 11:44:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:44:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:44:26 INFO - (blobuploader) - INFO - Open directory for files ... 11:44:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:44:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:44:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:44:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:44:27 INFO - (blobuploader) - INFO - Done attempting. 11:44:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:44:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:44:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:44:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:44:30 INFO - (blobuploader) - INFO - Done attempting. 11:44:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:44:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:44:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:44:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:44:31 INFO - (blobuploader) - INFO - Done attempting. 11:44:31 INFO - (blobuploader) - INFO - Iteration through files over. 11:44:31 INFO - Return code: 0 11:44:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:44:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:44:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/acbbd2f23ad53b68823f0bc647c54350f2263080d3d0716fafad1cf19ae5a462a2dc9721b06fcdc2dfc6d8482d2328353f3cb97f79524e4be2dda1d2a99d7849", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/19e2a53ac255e29b83e79b5ab1bf7401b915f5e7cdccf22d7ce665ea66474a7b973cd8900847228a0e13c3ff0b9d3c5fe71988c1af66928f6c87bf04fd35c78c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0ad3c27a09c81398ad6c25cb7841cd2a0be0e33de911295aaf667f3fd71378df0cc0fd5db71316c4359224b1c97d0371121841caace04d3f54461c3c04123da8"} 11:44:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:44:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:44:31 INFO - Contents: 11:44:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/acbbd2f23ad53b68823f0bc647c54350f2263080d3d0716fafad1cf19ae5a462a2dc9721b06fcdc2dfc6d8482d2328353f3cb97f79524e4be2dda1d2a99d7849", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/19e2a53ac255e29b83e79b5ab1bf7401b915f5e7cdccf22d7ce665ea66474a7b973cd8900847228a0e13c3ff0b9d3c5fe71988c1af66928f6c87bf04fd35c78c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0ad3c27a09c81398ad6c25cb7841cd2a0be0e33de911295aaf667f3fd71378df0cc0fd5db71316c4359224b1c97d0371121841caace04d3f54461c3c04123da8"} 11:44:31 INFO - Running post-run listener: copy_logs_to_upload_dir 11:44:31 INFO - Copying logs to upload dir... 11:44:31 INFO - mkdir: /builds/slave/test/build/upload/logs 11:44:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.082537 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-08-05 11:44:31.522554) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 11:44:31.528819) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1470421432.836438-1338878370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/acbbd2f23ad53b68823f0bc647c54350f2263080d3d0716fafad1cf19ae5a462a2dc9721b06fcdc2dfc6d8482d2328353f3cb97f79524e4be2dda1d2a99d7849", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/19e2a53ac255e29b83e79b5ab1bf7401b915f5e7cdccf22d7ce665ea66474a7b973cd8900847228a0e13c3ff0b9d3c5fe71988c1af66928f6c87bf04fd35c78c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0ad3c27a09c81398ad6c25cb7841cd2a0be0e33de911295aaf667f3fd71378df0cc0fd5db71316c4359224b1c97d0371121841caace04d3f54461c3c04123da8"} build_url:https://queue.taskcluster.net/v1/task/H3M2V4CaRMm8vgmUv0o7Hw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011248 build_url: 'https://queue.taskcluster.net/v1/task/H3M2V4CaRMm8vgmUv0o7Hw/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/Fx-Team/sha512/acbbd2f23ad53b68823f0bc647c54350f2263080d3d0716fafad1cf19ae5a462a2dc9721b06fcdc2dfc6d8482d2328353f3cb97f79524e4be2dda1d2a99d7849", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/19e2a53ac255e29b83e79b5ab1bf7401b915f5e7cdccf22d7ce665ea66474a7b973cd8900847228a0e13c3ff0b9d3c5fe71988c1af66928f6c87bf04fd35c78c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0ad3c27a09c81398ad6c25cb7841cd2a0be0e33de911295aaf667f3fd71378df0cc0fd5db71316c4359224b1c97d0371121841caace04d3f54461c3c04123da8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 11:44:31.554202) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 11:44:31.554562) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1470421432.836438-1338878370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004431 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 11:44:31.640502) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 11:44:31.640827) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 11:44:31.641147) ========= ========= Total master_lag: 0.17 =========