builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-068 starttime: 1472797998.69 results: success (0) buildid: 20160901203019 builduid: 96f48c5383af4306a6fa611722512dd4 revision: 4f8bafdd88dc6cfdb5b5fe074dfb5d1abdb2f20c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 23:33:18.686300) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 23:33:18.686806) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 23:33:18.687116) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 23:33:18.788627) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 23:33:18.788933) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1472797358.455263-1680859295 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-01 23:33:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2016-09-01 23:33:20 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107904 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 23:33:18.915420) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 23:33:18.918837) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1472797358.455263-1680859295 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015745 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 23:33:18.969561) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-01 23:33:18.973004) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4f8bafdd88dc6cfdb5b5fe074dfb5d1abdb2f20c --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 4f8bafdd88dc6cfdb5b5fe074dfb5d1abdb2f20c --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=97facb8ba2ac28944cc45e6b000001d4-1472797358.455263-1680859295 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-01 23:33:20,695 truncating revision to first 12 chars 2016-09-01 23:33:20,696 Setting DEBUG logging. 2016-09-01 23:33:20,696 attempt 1/10 2016-09-01 23:33:20,696 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4f8bafdd88dc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-01 23:33:21,402 unpacking tar archive at: fx-team-4f8bafdd88dc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.050960 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-01 23:33:20.038149) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 23:33:20.038490) ========= script_repo_revision: 4f8bafdd88dc6cfdb5b5fe074dfb5d1abdb2f20c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 23:33:20.038962) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 23:33:20.039273) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 23:33:20.048001) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-09-01 23:33:20.048308) ========= /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=97facb8ba2ac28944cc45e6b000001d4-1472797358.455263-1680859295 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:33:21 INFO - MultiFileLogger online at 20160901 23:33:21 in /builds/slave/test 23:33:21 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 23:33:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:33:21 INFO - {'append_to_log': False, 23:33:21 INFO - 'base_work_dir': '/builds/slave/test', 23:33:21 INFO - 'blob_upload_branch': 'Fx-Team', 23:33:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:33:21 INFO - 'branch': 'Fx-Team', 23:33:21 INFO - 'buildbot_json_path': 'buildprops.json', 23:33:21 INFO - 'config_files': ('talos/linux_config.py',), 23:33:21 INFO - 'default_actions': ('clobber', 23:33:21 INFO - 'read-buildbot-config', 23:33:21 INFO - 'download-and-extract', 23:33:21 INFO - 'populate-webroot', 23:33:21 INFO - 'create-virtualenv', 23:33:21 INFO - 'install', 23:33:21 INFO - 'run-tests'), 23:33:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:33:21 INFO - 'download_minidump_stackwalk': True, 23:33:21 INFO - 'download_symbols': 'ondemand', 23:33:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:33:21 INFO - 'tooltool.py': '/tools/tooltool.py', 23:33:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:33:21 INFO - '/tools/misc-python/virtualenv.py')}, 23:33:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:33:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:33:21 INFO - 'installer_path': 'installer.exe', 23:33:21 INFO - 'log_level': 'info', 23:33:21 INFO - 'log_name': 'talos', 23:33:21 INFO - 'log_to_console': True, 23:33:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:33:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:33:21 INFO - 'opt_config_files': (), 23:33:21 INFO - 'pip_index': False, 23:33:21 INFO - 'sps_profile': False, 23:33:21 INFO - 'sps_profile_interval': 0, 23:33:21 INFO - 'suite': 'dromaeojs', 23:33:21 INFO - 'system_bits': '32', 23:33:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:33:21 INFO - 'title': 'talos-linux64-ix-068', 23:33:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:33:21 INFO - 'use_talos_json': True, 23:33:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:33:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:33:21 INFO - 'work_dir': 'build'} 23:33:21 INFO - [mozharness: 2016-09-02 06:33:21.862613Z] Running clobber step. 23:33:21 INFO - Running pre-action listener: _resource_record_pre_action 23:33:21 INFO - Running main action method: clobber 23:33:21 INFO - rmtree: /builds/slave/test/build 23:33:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:33:22 INFO - Running post-action listener: _resource_record_post_action 23:33:22 INFO - [mozharness: 2016-09-02 06:33:22.327116Z] Finished clobber step (success) 23:33:22 INFO - [mozharness: 2016-09-02 06:33:22.327218Z] Running read-buildbot-config step. 23:33:22 INFO - Running pre-action listener: _resource_record_pre_action 23:33:22 INFO - Running main action method: read_buildbot_config 23:33:22 INFO - Using buildbot properties: 23:33:22 INFO - { 23:33:22 INFO - "project": "", 23:33:22 INFO - "product": "firefox", 23:33:22 INFO - "script_repo_revision": "production", 23:33:22 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 23:33:22 INFO - "repository": "", 23:33:22 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 23:33:22 INFO - "buildid": "20160901203019", 23:33:22 INFO - "pgo_build": "True", 23:33:22 INFO - "basedir": "/builds/slave/test", 23:33:22 INFO - "buildnumber": 1522, 23:33:22 INFO - "slavename": "talos-linux64-ix-068", 23:33:22 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 23:33:22 INFO - "platform": "ubuntu64_hw", 23:33:22 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:33:22 INFO - "branch": "fx-team", 23:33:22 INFO - "repo_path": "integration/fx-team", 23:33:22 INFO - "revision": "4f8bafdd88dc6cfdb5b5fe074dfb5d1abdb2f20c", 23:33:22 INFO - "stage_platform": "linux64-pgo", 23:33:22 INFO - "builduid": "96f48c5383af4306a6fa611722512dd4", 23:33:22 INFO - "slavebuilddir": "test" 23:33:22 INFO - } 23:33:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/W10e_HY_Qua1LTWSUl876A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 23:33:22 INFO - Running post-action listener: _resource_record_post_action 23:33:22 INFO - [mozharness: 2016-09-02 06:33:22.329689Z] Finished read-buildbot-config step (success) 23:33:22 INFO - [mozharness: 2016-09-02 06:33:22.329779Z] Running download-and-extract step. 23:33:22 INFO - Running pre-action listener: _resource_record_pre_action 23:33:22 INFO - Running main action method: download_and_extract 23:33:22 INFO - mkdir: /builds/slave/test/build/tests 23:33:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:33:22 INFO - trying https://queue.taskcluster.net/v1/task/W10e_HY_Qua1LTWSUl876A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 23:33:22 INFO - Downloading https://queue.taskcluster.net/v1/task/W10e_HY_Qua1LTWSUl876A/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 23:33:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W10e_HY_Qua1LTWSUl876A/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 23:33:22 INFO - Downloaded 1361 bytes. 23:33:22 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 23:33:22 INFO - Using the following test package requirements: 23:33:22 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 23:33:22 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:33:22 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:33:22 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:33:22 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:33:22 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:33:22 INFO - u'jsshell-linux-x86_64.zip'], 23:33:22 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:33:22 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:33:22 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 23:33:22 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:33:22 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:33:22 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:33:22 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:33:22 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:33:22 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:33:22 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:33:22 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:33:22 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:33:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:33:22 INFO - trying https://queue.taskcluster.net/v1/task/W10e_HY_Qua1LTWSUl876A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 23:33:22 INFO - Downloading https://queue.taskcluster.net/v1/task/W10e_HY_Qua1LTWSUl876A/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 23:33:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W10e_HY_Qua1LTWSUl876A/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 23:33:23 INFO - Downloaded 21906606 bytes. 23:33:23 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 23:33:28 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 23:33:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:33:28 INFO - trying https://queue.taskcluster.net/v1/task/W10e_HY_Qua1LTWSUl876A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 23:33:28 INFO - Downloading https://queue.taskcluster.net/v1/task/W10e_HY_Qua1LTWSUl876A/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 23:33:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W10e_HY_Qua1LTWSUl876A/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 23:33:28 INFO - Downloaded 21906606 bytes. 23:33:28 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 23:33:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:33:33 INFO - trying https://queue.taskcluster.net/v1/task/W10e_HY_Qua1LTWSUl876A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 23:33:33 INFO - Downloading https://queue.taskcluster.net/v1/task/W10e_HY_Qua1LTWSUl876A/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 23:33:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W10e_HY_Qua1LTWSUl876A/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 23:33:34 INFO - Downloaded 14413998 bytes. 23:33:34 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 23:33:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:33:34 INFO - trying https://queue.taskcluster.net/v1/task/W10e_HY_Qua1LTWSUl876A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:33:34 INFO - Downloading https://queue.taskcluster.net/v1/task/W10e_HY_Qua1LTWSUl876A/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 23:33:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W10e_HY_Qua1LTWSUl876A/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 23:33:35 INFO - Downloaded 59740906 bytes. 23:33:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/W10e_HY_Qua1LTWSUl876A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:33:35 INFO - mkdir: /builds/slave/test/properties 23:33:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:33:35 INFO - Writing to file /builds/slave/test/properties/build_url 23:33:35 INFO - Contents: 23:33:35 INFO - build_url:https://queue.taskcluster.net/v1/task/W10e_HY_Qua1LTWSUl876A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:33:36 INFO - Running post-action listener: _resource_record_post_action 23:33:36 INFO - Running post-action listener: set_extra_try_arguments 23:33:36 INFO - [mozharness: 2016-09-02 06:33:36.249818Z] Finished download-and-extract step (success) 23:33:36 INFO - [mozharness: 2016-09-02 06:33:36.250045Z] Running populate-webroot step. 23:33:36 INFO - Running pre-action listener: _resource_record_pre_action 23:33:36 INFO - Running main action method: populate_webroot 23:33:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:33:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:33:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:33:36 INFO - '--tppagecycles', 23:33:36 INFO - '7'], 23:33:36 INFO - 'tests': ['tsvgm']}}, 23:33:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:33:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:33:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:33:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:33:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:33:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:33:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:33:36 INFO - 'talos_options': ['--disable-e10s'], 23:33:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:33:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:33:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:33:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:33:36 INFO - 'talos_options': ['--disable-e10s'], 23:33:36 INFO - 'tests': ['damp', 'tps']}, 23:33:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:33:36 INFO - 'tests': ['damp', 'tps']}, 23:33:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:33:36 INFO - 'tests': ['dromaeo_dom']}, 23:33:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:33:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:33:36 INFO - 'tests': ['basic_compositor_video']}, 23:33:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:33:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:33:36 INFO - 'tests': ['a11yr', 23:33:36 INFO - 'ts_paint', 23:33:36 INFO - 'tpaint', 23:33:36 INFO - 'sessionrestore', 23:33:36 INFO - 'sessionrestore_no_auto_restore', 23:33:36 INFO - 'tabpaint']}, 23:33:36 INFO - 'other-e10s': {'tests': ['a11yr', 23:33:36 INFO - 'ts_paint', 23:33:36 INFO - 'tpaint', 23:33:36 INFO - 'sessionrestore', 23:33:36 INFO - 'sessionrestore_no_auto_restore', 23:33:36 INFO - 'tabpaint']}, 23:33:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:33:36 INFO - 'ts_paint', 23:33:36 INFO - 'tpaint', 23:33:36 INFO - 'sessionrestore', 23:33:36 INFO - 'sessionrestore_no_auto_restore', 23:33:36 INFO - 'tabpaint']}, 23:33:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:33:36 INFO - 'ts_paint', 23:33:36 INFO - 'tpaint', 23:33:36 INFO - 'sessionrestore', 23:33:36 INFO - 'sessionrestore_no_auto_restore', 23:33:36 INFO - 'tabpaint']}, 23:33:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:33:36 INFO - 'tests': ['a11yr', 23:33:36 INFO - 'ts_paint', 23:33:36 INFO - 'tpaint', 23:33:36 INFO - 'sessionrestore', 23:33:36 INFO - 'sessionrestore_no_auto_restore', 23:33:36 INFO - 'tabpaint']}, 23:33:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:33:36 INFO - 'tests': ['a11yr', 23:33:36 INFO - 'ts_paint', 23:33:36 INFO - 'tpaint', 23:33:36 INFO - 'sessionrestore', 23:33:36 INFO - 'sessionrestore_no_auto_restore', 23:33:36 INFO - 'tabpaint']}, 23:33:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:33:36 INFO - 'tests': ['tsvgx', 23:33:36 INFO - 'tsvgr_opacity', 23:33:36 INFO - 'tart', 23:33:36 INFO - 'tscrollx', 23:33:36 INFO - 'cart']}, 23:33:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:33:36 INFO - 'tsvgr_opacity', 23:33:36 INFO - 'tart', 23:33:36 INFO - 'tscrollx', 23:33:36 INFO - 'cart']}, 23:33:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:33:36 INFO - 'talos_options': ['--disable-e10s'], 23:33:36 INFO - 'tests': ['tp5o']}, 23:33:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:33:36 INFO - 'tests': ['tp5o']}, 23:33:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:33:36 INFO - 'talos_options': ['--disable-e10s', 23:33:36 INFO - '--xperf_path', 23:33:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:33:36 INFO - 'tests': ['tp5n']}, 23:33:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:33:36 INFO - 'talos_options': ['--xperf_path', 23:33:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:33:36 INFO - 'tests': ['tp5n']}}, 23:33:36 INFO - 'talos.zip': {'path': '', 23:33:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:33:36 INFO - Running post-action listener: _resource_record_post_action 23:33:36 INFO - [mozharness: 2016-09-02 06:33:36.270157Z] Finished populate-webroot step (success) 23:33:36 INFO - [mozharness: 2016-09-02 06:33:36.270248Z] Running create-virtualenv step. 23:33:36 INFO - Running pre-action listener: _resource_record_pre_action 23:33:36 INFO - Running main action method: create_virtualenv 23:33:36 INFO - Creating virtualenv /builds/slave/test/build/venv 23:33:36 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 23:33:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:33:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:33:36 INFO - Using real prefix '/usr' 23:33:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:33:36 INFO - Installing distribute.............................................................................................................................................................................................done. 23:33:38 INFO - Installing pip.................done. 23:33:38 INFO - Return code: 0 23:33:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:33:38 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')]} 23:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:33:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:33:38 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')]} 23:33:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:33:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:33:38 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 0x7f3ba5672f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c48850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c43370>, '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 0x2c468f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c46d80>, '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': '97facb8ba2ac28944cc45e6b000001d4-1472797358.455263-1680859295', '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 23:33:38 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 23:33:38 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 23:33:38 INFO - Using env: {'DISPLAY': ':0', 23:33:38 INFO - 'HOME': '/home/cltbld', 23:33:38 INFO - 'LANG': 'en_US.UTF-8', 23:33:38 INFO - 'LANGUAGE': 'en_US:en', 23:33:38 INFO - 'LOGNAME': 'cltbld', 23:33:38 INFO - 'MAIL': '/var/mail/cltbld', 23:33:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:33:38 INFO - 'MOZ_NO_REMOTE': '1', 23:33:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:33:38 INFO - 'NO_EM_RESTART': '1', 23:33:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:33:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:33:38 INFO - 'PWD': '/builds/slave/test', 23:33:38 INFO - 'SHELL': '/bin/bash', 23:33:38 INFO - 'SHLVL': '1', 23:33:38 INFO - 'TERM': 'linux', 23:33:38 INFO - 'TMOUT': '86400', 23:33:38 INFO - 'USER': 'cltbld', 23:33:38 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1472797358.455263-1680859295', 23:33:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:33:38 INFO - '_': '/tools/buildbot/bin/python'} 23:33:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:33:39 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 23:33:39 INFO - Cleaning up... 23:33:39 INFO - Return code: 0 23:33:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:33:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:33:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:33:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:33:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:33:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:33:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:33:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3ba5672f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c48850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c43370>, '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 0x2c468f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c46d80>, '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': '97facb8ba2ac28944cc45e6b000001d4-1472797358.455263-1680859295', '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 23:33:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 23:33:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 23:33:39 INFO - Using env: {'DISPLAY': ':0', 23:33:39 INFO - 'HOME': '/home/cltbld', 23:33:39 INFO - 'LANG': 'en_US.UTF-8', 23:33:39 INFO - 'LANGUAGE': 'en_US:en', 23:33:39 INFO - 'LOGNAME': 'cltbld', 23:33:39 INFO - 'MAIL': '/var/mail/cltbld', 23:33:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:33:39 INFO - 'MOZ_NO_REMOTE': '1', 23:33:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:33:39 INFO - 'NO_EM_RESTART': '1', 23:33:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:33:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:33:39 INFO - 'PWD': '/builds/slave/test', 23:33:39 INFO - 'SHELL': '/bin/bash', 23:33:39 INFO - 'SHLVL': '1', 23:33:39 INFO - 'TERM': 'linux', 23:33:39 INFO - 'TMOUT': '86400', 23:33:39 INFO - 'USER': 'cltbld', 23:33:39 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1472797358.455263-1680859295', 23:33:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:33:39 INFO - '_': '/tools/buildbot/bin/python'} 23:33:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:33:39 INFO - Downloading/unpacking psutil>=3.1.1 23:33:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:33:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:33:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:33:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:33:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:33:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:33:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:33:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:33:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:33:41 INFO - Installing collected packages: psutil 23:33:41 INFO - Running setup.py install for psutil 23:33:41 INFO - building 'psutil._psutil_linux' extension 23:33:41 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 23:33:41 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 23:33:41 INFO - building 'psutil._psutil_posix' extension 23:33:41 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 23:33:41 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 23:33:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:33:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:33:41 INFO - Successfully installed psutil 23:33:41 INFO - Cleaning up... 23:33:41 INFO - Return code: 0 23:33:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:33:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:33:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:33:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:33:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:33:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:33:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3ba5672f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c48850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c43370>, '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 0x2c468f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c46d80>, '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': '97facb8ba2ac28944cc45e6b000001d4-1472797358.455263-1680859295', '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 23:33:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:33:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:33:41 INFO - Using env: {'DISPLAY': ':0', 23:33:41 INFO - 'HOME': '/home/cltbld', 23:33:41 INFO - 'LANG': 'en_US.UTF-8', 23:33:41 INFO - 'LANGUAGE': 'en_US:en', 23:33:41 INFO - 'LOGNAME': 'cltbld', 23:33:41 INFO - 'MAIL': '/var/mail/cltbld', 23:33:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:33:41 INFO - 'MOZ_NO_REMOTE': '1', 23:33:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:33:41 INFO - 'NO_EM_RESTART': '1', 23:33:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:33:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:33:41 INFO - 'PWD': '/builds/slave/test', 23:33:41 INFO - 'SHELL': '/bin/bash', 23:33:41 INFO - 'SHLVL': '1', 23:33:41 INFO - 'TERM': 'linux', 23:33:41 INFO - 'TMOUT': '86400', 23:33:41 INFO - 'USER': 'cltbld', 23:33:41 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1472797358.455263-1680859295', 23:33:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:33:41 INFO - '_': '/tools/buildbot/bin/python'} 23:33:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:33:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:33:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:33:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:33:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:33:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:33:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:33:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:33:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:33:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:33:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:33:43 INFO - Installing collected packages: mozsystemmonitor 23:33:43 INFO - Running setup.py install for mozsystemmonitor 23:33:44 INFO - Successfully installed mozsystemmonitor 23:33:44 INFO - Cleaning up... 23:33:44 INFO - Return code: 0 23:33:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:33:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:33:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:33:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:33:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:33:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:33:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:33:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3ba5672f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c48850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c43370>, '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 0x2c468f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c46d80>, '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': '97facb8ba2ac28944cc45e6b000001d4-1472797358.455263-1680859295', '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 23:33:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 23:33:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 23:33:44 INFO - Using env: {'DISPLAY': ':0', 23:33:44 INFO - 'HOME': '/home/cltbld', 23:33:44 INFO - 'LANG': 'en_US.UTF-8', 23:33:44 INFO - 'LANGUAGE': 'en_US:en', 23:33:44 INFO - 'LOGNAME': 'cltbld', 23:33:44 INFO - 'MAIL': '/var/mail/cltbld', 23:33:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:33:44 INFO - 'MOZ_NO_REMOTE': '1', 23:33:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:33:44 INFO - 'NO_EM_RESTART': '1', 23:33:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:33:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:33:44 INFO - 'PWD': '/builds/slave/test', 23:33:44 INFO - 'SHELL': '/bin/bash', 23:33:44 INFO - 'SHLVL': '1', 23:33:44 INFO - 'TERM': 'linux', 23:33:44 INFO - 'TMOUT': '86400', 23:33:44 INFO - 'USER': 'cltbld', 23:33:44 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1472797358.455263-1680859295', 23:33:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:33:44 INFO - '_': '/tools/buildbot/bin/python'} 23:33:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:33:44 INFO - Downloading/unpacking jsonschema==2.5.1 23:33:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:33:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:33:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:33:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:33:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:33:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:33:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:33:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:33:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:33:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:33:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:33:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:33:46 INFO - Downloading functools32-3.2.3-2.tar.gz 23:33:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:33:46 INFO - warning: no files found matching '*.txt' 23:33:46 INFO - no previously-included directories found matching 'build' 23:33:46 INFO - no previously-included directories found matching 'dist' 23:33:46 INFO - no previously-included directories found matching '.git*' 23:33:46 INFO - Installing collected packages: jsonschema, functools32 23:33:46 INFO - Running setup.py install for functools32 23:33:46 INFO - warning: no files found matching '*.txt' 23:33:46 INFO - no previously-included directories found matching 'build' 23:33:46 INFO - no previously-included directories found matching 'dist' 23:33:46 INFO - no previously-included directories found matching '.git*' 23:33:46 INFO - Successfully installed jsonschema functools32 23:33:46 INFO - Cleaning up... 23:33:46 INFO - Return code: 0 23:33:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:33:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:33:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:33:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:33:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:33:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:33:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3ba5672f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c48850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c43370>, '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 0x2c468f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c46d80>, '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': '97facb8ba2ac28944cc45e6b000001d4-1472797358.455263-1680859295', '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 23:33:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 23:33:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 23:33:46 INFO - Using env: {'DISPLAY': ':0', 23:33:46 INFO - 'HOME': '/home/cltbld', 23:33:46 INFO - 'LANG': 'en_US.UTF-8', 23:33:46 INFO - 'LANGUAGE': 'en_US:en', 23:33:46 INFO - 'LOGNAME': 'cltbld', 23:33:46 INFO - 'MAIL': '/var/mail/cltbld', 23:33:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:33:46 INFO - 'MOZ_NO_REMOTE': '1', 23:33:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:33:46 INFO - 'NO_EM_RESTART': '1', 23:33:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:33:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:33:46 INFO - 'PWD': '/builds/slave/test', 23:33:46 INFO - 'SHELL': '/bin/bash', 23:33:46 INFO - 'SHLVL': '1', 23:33:46 INFO - 'TERM': 'linux', 23:33:46 INFO - 'TMOUT': '86400', 23:33:46 INFO - 'USER': 'cltbld', 23:33:46 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1472797358.455263-1680859295', 23:33:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:33:46 INFO - '_': '/tools/buildbot/bin/python'} 23:33:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:33:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:33:46 INFO - Cleaning up... 23:33:46 INFO - Return code: 0 23:33:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:33:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:33:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:33:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:33:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:33:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:33:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3ba5672f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c48850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c43370>, '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 0x2c468f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c46d80>, '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': '97facb8ba2ac28944cc45e6b000001d4-1472797358.455263-1680859295', '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 23:33:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:33:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:33:46 INFO - Using env: {'DISPLAY': ':0', 23:33:46 INFO - 'HOME': '/home/cltbld', 23:33:46 INFO - 'LANG': 'en_US.UTF-8', 23:33:46 INFO - 'LANGUAGE': 'en_US:en', 23:33:46 INFO - 'LOGNAME': 'cltbld', 23:33:46 INFO - 'MAIL': '/var/mail/cltbld', 23:33:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:33:46 INFO - 'MOZ_NO_REMOTE': '1', 23:33:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:33:46 INFO - 'NO_EM_RESTART': '1', 23:33:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:33:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:33:46 INFO - 'PWD': '/builds/slave/test', 23:33:46 INFO - 'SHELL': '/bin/bash', 23:33:46 INFO - 'SHLVL': '1', 23:33:46 INFO - 'TERM': 'linux', 23:33:46 INFO - 'TMOUT': '86400', 23:33:46 INFO - 'USER': 'cltbld', 23:33:46 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1472797358.455263-1680859295', 23:33:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:33:46 INFO - '_': '/tools/buildbot/bin/python'} 23:33:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:33:47 INFO - Downloading/unpacking blobuploader==1.2.4 23:33:47 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 23:33:47 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 23:33:47 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 23:33:47 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 23:33:47 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 23:33:47 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 23:33:49 INFO - Downloading blobuploader-1.2.4.tar.gz 23:33:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:33:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:33:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:33:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:33:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:33:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:33:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:33:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:33:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:33:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:33:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:33:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:33:49 INFO - Downloading docopt-0.6.1.tar.gz 23:33:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:33:49 INFO - Installing collected packages: blobuploader, requests, docopt 23:33:49 INFO - Running setup.py install for blobuploader 23:33:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:33:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:33:49 INFO - Running setup.py install for requests 23:33:50 INFO - Running setup.py install for docopt 23:33:50 INFO - Successfully installed blobuploader requests docopt 23:33:50 INFO - Cleaning up... 23:33:50 INFO - Return code: 0 23:33:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:33:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:33:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:33:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:33:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:33:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:33:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:33:50 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 0x7f3ba5672f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c48850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c43370>, '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 0x2c468f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c46d80>, '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': '97facb8ba2ac28944cc45e6b000001d4-1472797358.455263-1680859295', '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 23:33:50 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 23:33:50 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 23:33:50 INFO - Using env: {'DISPLAY': ':0', 23:33:50 INFO - 'HOME': '/home/cltbld', 23:33:50 INFO - 'LANG': 'en_US.UTF-8', 23:33:50 INFO - 'LANGUAGE': 'en_US:en', 23:33:50 INFO - 'LOGNAME': 'cltbld', 23:33:50 INFO - 'MAIL': '/var/mail/cltbld', 23:33:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:33:50 INFO - 'MOZ_NO_REMOTE': '1', 23:33:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:33:50 INFO - 'NO_EM_RESTART': '1', 23:33:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:33:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:33:50 INFO - 'PWD': '/builds/slave/test', 23:33:50 INFO - 'SHELL': '/bin/bash', 23:33:50 INFO - 'SHLVL': '1', 23:33:50 INFO - 'TERM': 'linux', 23:33:50 INFO - 'TMOUT': '86400', 23:33:50 INFO - 'USER': 'cltbld', 23:33:50 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1472797358.455263-1680859295', 23:33:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:33:50 INFO - '_': '/tools/buildbot/bin/python'} 23:33:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:33:50 INFO - Running setup.py (path:/tmp/pip-VnfAjW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:33:50 INFO - Running setup.py (path:/tmp/pip-CstweP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:33:50 INFO - Running setup.py (path:/tmp/pip-MdA_Zp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:33:50 INFO - Running setup.py (path:/tmp/pip-6gLh20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:33:50 INFO - Running setup.py (path:/tmp/pip-LrxdQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:33:50 INFO - Running setup.py (path:/tmp/pip-rOFSXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:33:51 INFO - Running setup.py (path:/tmp/pip-rMT4S6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:33:51 INFO - Running setup.py (path:/tmp/pip-e2gMHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:33:51 INFO - Running setup.py (path:/tmp/pip-E_g0dr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:33:51 INFO - Running setup.py (path:/tmp/pip-ZOEcd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:33:51 INFO - Running setup.py (path:/tmp/pip-AXBdYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:33:51 INFO - Running setup.py (path:/tmp/pip-nFwgkA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:33:51 INFO - Running setup.py (path:/tmp/pip-hT9dJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:33:51 INFO - Running setup.py (path:/tmp/pip-K79brP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:33:51 INFO - Running setup.py (path:/tmp/pip-7d78or-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:33:51 INFO - Running setup.py (path:/tmp/pip-bC5aFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:33:51 INFO - Running setup.py (path:/tmp/pip-F6AFXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:33:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:33:51 INFO - Running setup.py install for manifestparser 23:33:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:33:51 INFO - Running setup.py install for mozcrash 23:33:52 INFO - Running setup.py install for mozdebug 23:33:52 INFO - Running setup.py install for mozdevice 23:33:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:33:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:33:52 INFO - Running setup.py install for mozfile 23:33:52 INFO - Running setup.py install for mozhttpd 23:33:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:33:52 INFO - Running setup.py install for mozinfo 23:33:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:33:52 INFO - Running setup.py install for mozInstall 23:33:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:33:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:33:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:33:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:33:52 INFO - Running setup.py install for mozleak 23:33:52 INFO - Running setup.py install for mozlog 23:33:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:33:52 INFO - Running setup.py install for moznetwork 23:33:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:33:52 INFO - Running setup.py install for mozprocess 23:33:53 INFO - Running setup.py install for mozprofile 23:33:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:33:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:33:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:33:53 INFO - Running setup.py install for mozrunner 23:33:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:33:53 INFO - Running setup.py install for mozscreenshot 23:33:53 INFO - Running setup.py install for moztest 23:33:53 INFO - Running setup.py install for mozversion 23:33:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:33:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:33:53 INFO - Cleaning up... 23:33:53 INFO - Return code: 0 23:33:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:33:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:33:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:33:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:33:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:33:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:33:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:33:53 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 0x7f3ba5672f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c48850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c43370>, '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 0x2c468f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c46d80>, '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': '97facb8ba2ac28944cc45e6b000001d4-1472797358.455263-1680859295', '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 23:33:53 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 23:33:53 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 23:33:53 INFO - Using env: {'DISPLAY': ':0', 23:33:53 INFO - 'HOME': '/home/cltbld', 23:33:53 INFO - 'LANG': 'en_US.UTF-8', 23:33:53 INFO - 'LANGUAGE': 'en_US:en', 23:33:53 INFO - 'LOGNAME': 'cltbld', 23:33:53 INFO - 'MAIL': '/var/mail/cltbld', 23:33:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:33:53 INFO - 'MOZ_NO_REMOTE': '1', 23:33:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:33:53 INFO - 'NO_EM_RESTART': '1', 23:33:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:33:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:33:53 INFO - 'PWD': '/builds/slave/test', 23:33:53 INFO - 'SHELL': '/bin/bash', 23:33:53 INFO - 'SHLVL': '1', 23:33:53 INFO - 'TERM': 'linux', 23:33:53 INFO - 'TMOUT': '86400', 23:33:53 INFO - 'USER': 'cltbld', 23:33:53 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1472797358.455263-1680859295', 23:33:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:33:53 INFO - '_': '/tools/buildbot/bin/python'} 23:33:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:33:53 INFO - Running setup.py (path:/tmp/pip-YAyu1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:33:53 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)) 23:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:33:53 INFO - Running setup.py (path:/tmp/pip-ceHCFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:33:54 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)) 23:33:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:33:54 INFO - Running setup.py (path:/tmp/pip-h8JQXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:33:54 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)) 23:33:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:33:54 INFO - Running setup.py (path:/tmp/pip-tD_7h4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:33:54 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)) 23:33:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:33:54 INFO - Running setup.py (path:/tmp/pip-QwsbUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:33:54 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)) 23:33:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:33:54 INFO - Running setup.py (path:/tmp/pip-UnxCUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:33:54 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)) 23:33:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:33:54 INFO - Running setup.py (path:/tmp/pip-gS4MeW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:33:54 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)) 23:33:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:33:54 INFO - Running setup.py (path:/tmp/pip-7u1I70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:33:54 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)) 23:33:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:33:54 INFO - Running setup.py (path:/tmp/pip-yU7NYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:33:54 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)) 23:33:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:33:54 INFO - Running setup.py (path:/tmp/pip-nhgrmY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:33:54 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)) 23:33:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:33:54 INFO - Running setup.py (path:/tmp/pip-aRFY4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:33:54 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)) 23:33:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:33:54 INFO - Running setup.py (path:/tmp/pip-ycf7P4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:33:54 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)) 23:33:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:33:54 INFO - Running setup.py (path:/tmp/pip-HSSlah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:33:54 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)) 23:33:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:33:54 INFO - Running setup.py (path:/tmp/pip-oYXucq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:33:54 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)) 23:33:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:33:54 INFO - Running setup.py (path:/tmp/pip-ZYATGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:33:55 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)) 23:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:33:55 INFO - Running setup.py (path:/tmp/pip-5iI8xd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:33:55 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)) 23:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:33:55 INFO - Running setup.py (path:/tmp/pip-lUEMGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:33:55 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)) 23:33:55 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)) 23:33:55 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)) 23:33:55 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)) 23:33:55 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)) 23:33:55 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)) 23:33:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:33:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:33:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:33:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:33:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:33:57 INFO - Downloading blessings-1.6.tar.gz 23:33:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:33:57 INFO - Installing collected packages: blessings 23:33:57 INFO - Running setup.py install for blessings 23:33:57 INFO - Successfully installed blessings 23:33:57 INFO - Cleaning up... 23:33:57 INFO - Return code: 0 23:33:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:33:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:33:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:33:57 INFO - Reading from file tmpfile_stdout 23:33:57 INFO - Current package versions: 23:33:57 INFO - argparse == 1.2.1 23:33:57 INFO - blessings == 1.6 23:33:57 INFO - blobuploader == 1.2.4 23:33:57 INFO - docopt == 0.6.1 23:33:57 INFO - functools32 == 3.2.3-2 23:33:57 INFO - jsonschema == 2.5.1 23:33:57 INFO - manifestparser == 1.1 23:33:57 INFO - mozInstall == 1.12 23:33:57 INFO - mozcrash == 0.17 23:33:57 INFO - mozdebug == 0.1 23:33:57 INFO - mozdevice == 0.48 23:33:57 INFO - mozfile == 1.2 23:33:57 INFO - mozhttpd == 0.7 23:33:57 INFO - mozinfo == 0.9 23:33:57 INFO - mozleak == 0.1 23:33:57 INFO - mozlog == 3.3 23:33:57 INFO - moznetwork == 0.27 23:33:57 INFO - mozprocess == 0.23 23:33:57 INFO - mozprofile == 0.28 23:33:57 INFO - mozrunner == 6.12 23:33:57 INFO - mozscreenshot == 0.1 23:33:57 INFO - mozsystemmonitor == 0.3 23:33:57 INFO - moztest == 0.7 23:33:57 INFO - mozversion == 1.4 23:33:57 INFO - psutil == 3.1.1 23:33:57 INFO - requests == 1.2.3 23:33:57 INFO - wsgiref == 0.1.2 23:33:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:33:57 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')]} 23:33:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:33:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:33:57 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')]} 23:33:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:33:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:33:57 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 0x7f3ba5672f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c48850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c43370>, '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 0x2c468f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c46d80>, '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': '97facb8ba2ac28944cc45e6b000001d4-1472797358.455263-1680859295', '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 23:33:57 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 23:33:57 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 23:33:57 INFO - Using env: {'DISPLAY': ':0', 23:33:57 INFO - 'HOME': '/home/cltbld', 23:33:57 INFO - 'LANG': 'en_US.UTF-8', 23:33:57 INFO - 'LANGUAGE': 'en_US:en', 23:33:57 INFO - 'LOGNAME': 'cltbld', 23:33:57 INFO - 'MAIL': '/var/mail/cltbld', 23:33:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:33:57 INFO - 'MOZ_NO_REMOTE': '1', 23:33:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:33:57 INFO - 'NO_EM_RESTART': '1', 23:33:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:33:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:33:57 INFO - 'PWD': '/builds/slave/test', 23:33:57 INFO - 'SHELL': '/bin/bash', 23:33:57 INFO - 'SHLVL': '1', 23:33:57 INFO - 'TERM': 'linux', 23:33:57 INFO - 'TMOUT': '86400', 23:33:57 INFO - 'USER': 'cltbld', 23:33:57 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1472797358.455263-1680859295', 23:33:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:33:57 INFO - '_': '/tools/buildbot/bin/python'} 23:33:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:33:57 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)) 23:33:57 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)) 23:33:57 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)) 23:33:57 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)) 23:33:57 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)) 23:33:57 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)) 23:33:57 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)) 23:33:57 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)) 23:33:57 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)) 23:33:57 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)) 23:33:57 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)) 23:33:57 INFO - Cleaning up... 23:33:57 INFO - Return code: 0 23:33:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:33:57 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')]} 23:33:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:33:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:33:57 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')]} 23:33:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:33:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:33:57 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 0x7f3ba5672f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c48850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c43370>, '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 0x2c468f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c46d80>, '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': '97facb8ba2ac28944cc45e6b000001d4-1472797358.455263-1680859295', '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 23:33:57 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 23:33:57 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 23:33:57 INFO - Using env: {'DISPLAY': ':0', 23:33:57 INFO - 'HOME': '/home/cltbld', 23:33:57 INFO - 'LANG': 'en_US.UTF-8', 23:33:57 INFO - 'LANGUAGE': 'en_US:en', 23:33:57 INFO - 'LOGNAME': 'cltbld', 23:33:57 INFO - 'MAIL': '/var/mail/cltbld', 23:33:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:33:57 INFO - 'MOZ_NO_REMOTE': '1', 23:33:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:33:57 INFO - 'NO_EM_RESTART': '1', 23:33:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:33:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:33:57 INFO - 'PWD': '/builds/slave/test', 23:33:57 INFO - 'SHELL': '/bin/bash', 23:33:57 INFO - 'SHLVL': '1', 23:33:57 INFO - 'TERM': 'linux', 23:33:57 INFO - 'TMOUT': '86400', 23:33:57 INFO - 'USER': 'cltbld', 23:33:57 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1472797358.455263-1680859295', 23:33:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:33:57 INFO - '_': '/tools/buildbot/bin/python'} 23:33:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:33:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:33:57 INFO - Cleaning up... 23:33:57 INFO - Return code: 0 23:33:57 INFO - Running post-action listener: _resource_record_post_action 23:33:57 INFO - Running post-action listener: _start_resource_monitoring 23:33:57 INFO - Starting resource monitoring. 23:33:57 INFO - [mozharness: 2016-09-02 06:33:57.996674Z] Finished create-virtualenv step (success) 23:33:57 INFO - [mozharness: 2016-09-02 06:33:57.997269Z] Running install step. 23:33:57 INFO - Running pre-action listener: _resource_record_pre_action 23:33:57 INFO - Running main action method: install 23:33:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:33:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:33:58 INFO - Reading from file tmpfile_stdout 23:33:58 INFO - Detecting whether we're running mozinstall >=1.0... 23:33:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:33:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:33:58 INFO - Reading from file tmpfile_stdout 23:33:58 INFO - Output received: 23:33:58 INFO - Usage: mozinstall [options] installer 23:33:58 INFO - Options: 23:33:58 INFO - -h, --help show this help message and exit 23:33:58 INFO - -d DEST, --destination=DEST 23:33:58 INFO - Directory to install application into. [default: 23:33:58 INFO - "/builds/slave/test"] 23:33:58 INFO - --app=APP Application being installed. [default: firefox] 23:33:58 INFO - mkdir: /builds/slave/test/build/application 23:33:58 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'] 23:33:58 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 23:34:15 INFO - Reading from file tmpfile_stdout 23:34:15 INFO - Output received: 23:34:15 INFO - /builds/slave/test/build/application/firefox/firefox 23:34:15 INFO - Running post-action listener: _resource_record_post_action 23:34:15 INFO - [mozharness: 2016-09-02 06:34:15.351850Z] Finished install step (success) 23:34:15 INFO - [mozharness: 2016-09-02 06:34:15.352103Z] Running run-tests step. 23:34:15 INFO - Running pre-action listener: _resource_record_pre_action 23:34:15 INFO - Running main action method: run_tests 23:34:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:34:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:34:15 INFO - Python 2.7.3 23:34:15 INFO - Return code: 0 23:34:15 INFO - grabbing minidump binary from tooltool 23:34:15 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')]} 23:34:15 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 0x2c43370>, '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 0x2c468f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c46d80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:34:15 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 23:34:15 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 23:34:15 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 23:34:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:34:15 INFO - Return code: 0 23:34:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:34:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:34:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:34:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:34:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:34:15 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/W10e_HY_Qua1LTWSUl876A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 23:34:15 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/W10e_HY_Qua1LTWSUl876A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 23:34:15 INFO - Using env: {'DISPLAY': ':0', 23:34:15 INFO - 'HOME': '/home/cltbld', 23:34:15 INFO - 'LANG': 'en_US.UTF-8', 23:34:15 INFO - 'LANGUAGE': 'en_US:en', 23:34:15 INFO - 'LOGNAME': 'cltbld', 23:34:15 INFO - 'MAIL': '/var/mail/cltbld', 23:34:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:34:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:34:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:34:15 INFO - 'MOZ_NO_REMOTE': '1', 23:34:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:34:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:34:15 INFO - 'NO_EM_RESTART': '1', 23:34:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:34:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:34:15 INFO - 'PWD': '/builds/slave/test', 23:34:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:34:15 INFO - 'SHELL': '/bin/bash', 23:34:15 INFO - 'SHLVL': '1', 23:34:15 INFO - 'TERM': 'linux', 23:34:15 INFO - 'TMOUT': '86400', 23:34:15 INFO - 'USER': 'cltbld', 23:34:15 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1472797358.455263-1680859295', 23:34:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:34:15 INFO - '_': '/tools/buildbot/bin/python'} 23:34:15 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/W10e_HY_Qua1LTWSUl876A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 23:34:15 INFO - mozversion application_buildid: 20160901203019 23:34:15 INFO - mozversion application_changeset: 4f8bafdd88dc6cfdb5b5fe074dfb5d1abdb2f20c 23:34:15 INFO - mozversion application_display_name: Nightly 23:34:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:34:15 INFO - mozversion application_name: Firefox 23:34:15 INFO - mozversion application_remotingname: firefox 23:34:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:34:15 INFO - mozversion application_vendor: Mozilla 23:34:15 INFO - mozversion application_version: 51.0a1 23:34:15 INFO - mozversion platform_buildid: 20160901203019 23:34:15 INFO - mozversion platform_changeset: 4f8bafdd88dc6cfdb5b5fe074dfb5d1abdb2f20c 23:34:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:34:15 INFO - mozversion platform_version: 51.0a1 23:34:15 INFO - using testdate: 1472798055 23:34:15 INFO - actual date: 1472798055 23:34:15 INFO - starting webserver on 'localhost:39062' 23:34:15 INFO - SUITE-START | Running 2 tests 23:34:15 INFO - TEST-START | dromaeo_css 23:34:15 INFO - operating with platform_type : linux_ 23:34:15 INFO - Initialising browser for dromaeo_css test... 23:34:15 INFO - TEST-INFO | started process 11639 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLJc4jh/profile http://localhost:39062/getInfo.html) 23:34:20 INFO - PROCESS | 11639 | __metrics Screen width/height:1600/1200 23:34:20 INFO - PROCESS | 11639 | colorDepth:24 23:34:20 INFO - PROCESS | 11639 | Browser inner width/height: 1024/697 23:34:20 INFO - PROCESS | 11639 | __metrics 23:34:20 INFO - PROCESS | 11639 | 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" 23:34:20 INFO - PROCESS | 11639 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:34:21 INFO - PROCESS | 11639 | console.error: PushService: 23:34:21 INFO - PROCESS | 11639 | stateChangeProcessEnqueue: Error transitioning state 23:34:21 INFO - PROCESS | 11639 | UnknownError 23:34:21 INFO - TEST-INFO | 11639: exit 0 23:34:21 INFO - Browser initialized. 23:34:21 INFO - Running cycle 1/1 for dromaeo_css test... 23:34:21 INFO - TEST-INFO | started process 11723 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLJc4jh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:34:34 INFO - PROCESS | 11723 | RSS: Main: 182947840 23:34:34 INFO - PROCESS | 11723 | 23:35:25 INFO - PROCESS | 11723 | 1472798125470 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] 23:37:34 INFO - PROCESS | 11723 | Cycle 1(1): loaded http://localhost:39062/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39062/tests/dromaeo/cssquery-ext.html) 23:37:35 INFO - PROCESS | 11723 | RSS: Main: 288239616 23:37:35 INFO - PROCESS | 11723 | 23:40:38 INFO - PROCESS | 11723 | Cycle 1(1): loaded http://localhost:39062/tests/dromaeo/cssquery-ext.html (next: http://localhost:39062/tests/dromaeo/cssquery-jquery.html) 23:40:39 INFO - PROCESS | 11723 | RSS: Main: 270950400 23:40:39 INFO - PROCESS | 11723 | 23:43:41 INFO - PROCESS | 11723 | Cycle 1(1): loaded http://localhost:39062/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39062/tests/dromaeo/cssquery-mootools.html) 23:43:41 INFO - PROCESS | 11723 | RSS: Main: 215597056 23:43:41 INFO - PROCESS | 11723 | 23:46:43 INFO - PROCESS | 11723 | Cycle 1(1): loaded http://localhost:39062/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39062/tests/dromaeo/cssquery-prototype.html) 23:46:44 INFO - PROCESS | 11723 | RSS: Main: 243367936 23:46:44 INFO - PROCESS | 11723 | 23:49:47 INFO - PROCESS | 11723 | Cycle 1(1): loaded http://localhost:39062/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39062/tests/dromaeo/cssquery-yui.html) 23:49:47 INFO - PROCESS | 11723 | RSS: Main: 215228416 23:49:47 INFO - PROCESS | 11723 | 23:52:50 INFO - PROCESS | 11723 | Cycle 1(1): loaded http://localhost:39062/tests/dromaeo/cssquery-yui.html (next: http://localhost:39062/tests/dromaeo/cssquery-dojo.html) 23:52:50 INFO - PROCESS | 11723 | RSS: Main: 306311168 23:52:50 INFO - PROCESS | 11723 | 23:52:50 INFO - PROCESS | 11723 | __start_tp_report 23:52:50 INFO - PROCESS | 11723 | _x_x_mozilla_page_load 23:52:50 INFO - PROCESS | 11723 | _x_x_mozilla_page_load_details 23:52:50 INFO - PROCESS | 11723 | |i|pagename|runs| 23:52:50 INFO - PROCESS | 11723 | |0;dojo.html;3014.065639651708;3015.6531998820137;3041.9391612167756;3062.3262882165914;3089.9073027809172;5162.070827251093;5162.948370516294;5236.371635403757;5263.236830659557;5295.841124766253;5173.379194496656;5237.031149237384;5257.158854583267;5283.841484755454;5354.839354819352;4720.197566413718;4731.101090792738;4771.42742870856;4806.6875653082525;4827;4804.711717296956;4838.951610483903;4955.529224723646;4964.205727083649;4967.70193788372;4881.902361952741;4902.8038878444995;4922.26166075088;4925.556699897009;4960.280759289919;4684.32077348786;4692.976535117303;4721.504242054569;4777;4861.319415281863;4707.082118986799;4717.646176536739;4718.811247550094;4735.218688916325;4775.594074503671;5242.580593552545;5249.816256431045;5258.211268309746;5293.57651387888;5298.417174110845;5441.673499590037;5550.750216240239;5597.216389705444;5604.523615492688;5622.156676498517;5588.469095435927;5655.971720141414;5663.773449062032;5665.461781130827;5672.404397538282;5270.789168433258;5275.868103297448;5280.287161233223;5280.551153151987;5281.445448227958;5638;5650.011248031578;5687.976164290468;5693.259876216065;5810.912836307459;5500;5507.311586051744;5512.255845460892;5512.448755124456;5513.58648101394;5579.38626751057;5579.609427340048;5583.553315734732;5589.0219211637805;5598.188262701967;5433.266509021231;5500.339959204921;5540.778368865281;5547.667139971614;5634.070378387521;5581.330240371181;5591.720413979285;5592.217089607459;5593.720313984284;5599.1041433370465;4349.782510874444;4353.390525326457;4360.4331436913;4370.666946581323;4371.041847758599;3851.441540976543;3857.1128640412303;3891.7664940103687;3914.9608503915165;3979.184267225212;5301.840944771663;5307.9734601326745;5309.973450132802;5314.73426328682;5340.572754179656;5565.16522521625;5616.747246373923;5618.185363122325;5625.268715067015;5627.240322556484;5210.244514545369;5268.736563171826;5323.015242180131;5331.413544510101;5394.271773310631;4848.7090774553635;4863.878403039882;4864;4867.659263851497;4918.778654960463;5864.794732184353;5870.5010074144175;5882.323532793698;5884.205632239593;5885.588008839341;5516.448355164612;5621.690807005491;5681.204631351697;5684.886302274014;5778.393268706894;5860.033094539353;5872.970635146797;5873.765049397976;5874.295084589877;5875.265591801025;5613.607047506635;5618.185363122406;5620.74706638194;5620.8032718856275;5622.493975542221;5450.31871016123;5490.670559766427;5589.357223919302;5611.3266408031295;5671.773129074791;5466.098093814476;5482.259894914136;5483.287172667528;5507.779688812563;5508.338999320107;5414.079606466831;5455.481729235717;5469.644473109235;5471.097268950579;5528.530074943514;5347.572194224531;5407.918881216863;5413.160960051198;5419.214213939035;5522.861928451821;5478.178273259043;5508.20131080999;5510.476504732044;5516.696581688046;5522.420145884625;5398.13629819227;5398.757055932414;5399.109146990702;5418.593605479526;5475.09660905946 23:52:50 INFO - PROCESS | 11723 | |1;ext.html;556.5325126893408;595.2975488923071;612.4120843989768;627.3099590450505;627.7834147219207;32404.83797581012;42848.35727464087;43627.56372436275;43726.34410483841;43780.56219437805;46070.30894536576;46599;46800;46811.53188468114;46914.530854691446;8953.59708813105;9137.406068605553;9153.450792952412;9154.267658587298;9161.404508706913;8357.665693372257;10748.495210670513;10989.175811814106;10991.61529346473;11217.607383741572;10925.125989920787;11022.889771102307;11037.448127593629;11043.558257669683;11054.336739795597;10913.890861091406;11002.834957475645;11009.669709908716;11010.614628487965;11040.282381645167;10672.626458074008;10719.249652524326;10792.51433685486;10856.077233435168;10862.076723478514;43255.56744432547;43433.56566434327;43560;43670.56329436728;43935;3309.851056702454;3512.420450625669;3710.053936246267;3763.4919285896326;4159.396887451303;32483.350332993443;32859.34281314384;33390.41865341902;33498.6650133498;34693.6530634693;4079.9184016319805;4299.07569872479;4324.935125973113;4396.318570621559;4482.618977386926;232419.8379008111;232592;232662;233441;234514;61149.94250287468;62015.37984620186;62032.689836550526;62150.68924655438;62199.378006220264;36140.63859361373;36235;36812.07969800723;64353.678231609476;64562.35437645658;15262.084274943318;15351.539453816404;15356.692866142615;15363.385464581515;15376.692466150615;11687.415629218674;11927.284362938251;12169.69575760613;12263.877361226452;12279.263244205198;18923.24307027731;19454.16722520927;19478.247037302222;19488.83219193409;19550.965424337788;6951.339622735832;7017.89473157903;7089.184743754534;7163.89254161188;7188.173360063555;952.4951775558965;1024.4877561219391;1060.5492665617082;1084.5770149641646;1093.223811094132;31928.521072183936;32502;32744;33086.50370244448;33413.498797518056;1117.94969226385;1148.2019996102795;1148.3683973814368;1164.371239530661;1201.591458903977;15832.28754706041;16863.49409517692;16955.745663815054;17008.31966721342;17365.30538778435;520337;528846;529974;530344;531484;58345.41654583485;59023.40976590179;59084;59094.70452647709;59099;1192.8747481514315;1311.3902035553513;1327.8472975607929;1361.1288775183891;1370.917744935327;31080.68919310778;32708;33253.83373083119;33507.83246083754;33812.3237535243;50404;50934.74532627313;50939.235911460615;50941.745291273306;50951.74524127356;402679;403746;404333;405327;405530;27903.720962790114;28925.421491570472;29006.564901526915;30114.24714382158;30143.397132057675;48042.5195748038;48177;48890;48907.75546122246;49944;39116.2176756469;39344.80327598344;40250;40593.59406405898;42094.78952605218;40386.596134038286;40694;40871.38692919549;42089.57910420857;42264.366034508894;38984.80507597444;39501.604983949794;40979.795101024305;41608.375874362515;42439.36340954826;32559.34881302408;36479.27041459209;36847;37041.814790926954;37864;28215.15354539367;28403.43193136167;28539;28541;28633 23:52:50 INFO - PROCESS | 11723 | |2;jquery.html;376.9509963704718;393.54742046646356;394.9071968087499;398.4302447500075;422.39386480400606;16117.83882161178;19226.90386548067;19292.51768705783;19495.512612184702;20068.297609583668;18948;19094.140763665633;19237.519062023457;19417.514562135955;19835.404937851887;5688.089905615113;5857.531397488191;5887.116932460122;6472.579282346633;6839.213490448587;6821.931780682204;6857.725690972356;6858.485613579001;6863.416609588191;6891.1041564596535;6685.13093297873;6863.1764188297475;6868.347506986854;6891.827704307382;6902.275261097588;6698.028785826053;6841.692123854438;6872.244053154149;6881.41507971823;6917.100776898971;6474.223093228796;6502.219733631947;6508.8698226035685;6509.218893732783;6517.380848819402;23618;23897.163599274118;24201.515969680684;24402.389940251458;24468.877655611785;2451.6812814334203;2584.5993870949846;2621.659184306047;2708.0251109600526;2952.2324195709057;14218.715625687531;14442.711145777026;14883.107013579112;15090.5472835814;15163.317650705745;1890.2533499267713;1904.6381187574455;1959.4709428454237;1996.760388753359;2028.2495476673726;86188.56905715431;91844.99999999933;92648;92956.53521732416;94610;13847.930760346335;14034.719305613831;14183.14901105937;14219.573412797632;14582.854171458363;12393.318367489694;21719.348419547438;21790.346289611338;21822.345329640135;21855.235066772588;7725.613719314012;7870.409719271078;7964.800879978047;8175.305099066527;8244.093149753522;7873.25204105609;7932.325752311002;8161.63272652732;8167.183281671785;8222;4070.5522392536795;4166.6250037496775;4177.248095342807;4298.054428025829;4304.526502084768;1918.5395505078682;1926.0658580588404;1957.67698329774;1980.059541649192;2013.5771487987395;841.6254766628914;888.1074520107251;945.645382981382;966.2559828931824;974.2644303550774;17448.91275543614;17983.820161798478;18138.455846324632;19560.902195488932;19814.900925495567;922.6955104815395;940.7177846646116;965.7392504023874;1007.5466040281902;1028.5320179318392;10227.232957528215;10739.516721747541;10834.891651083546;10869.40218287986;10880.12958963281;455556;475775;480173;484302;486914;58596.70701646464;91563.54218228866;95013;97149;98097;958.1281034258791;977.2279898879948;997.3616885193481;997.7854761226226;1003.1673710820002;16721.080340581386;16948.152592370086;17444.21501032431;17448.563785905455;17451.214695338487;42144;42920.79676197199;43269.78365108154;43390;44470.77764611286;54932.450675492735;55664.44335556593;58691;58859;59699;7629.54222746637;7758.844823103619;7853.175416581405;8115.391345649218;8269;11630.302181869114;13393;13452.865471345161;13511.527096551574;13529.323533823466;11590.304581725124;11595.362255076052;11654.88345116538;11693.532258709896;12170.087243456954;11148.609798657008;11423.200375973602;11673.708157296136;11909.166358354832;12282.201656892274;11681.532738690357;11714.70713232176;12031.939840300742;12107.636770896886;12459.626211213677;7900.84198316042;8135.064467586303;8178.754637360888;8209.876851847346;8342.916570834213;11545.134114941246;11734.061275098142;11818.82271765907;11820.290782553075;12294.631161065183 23:52:50 INFO - PROCESS | 11723 | |3;mootools.html;1305.9216447013187;1452.2158034661284;1472.4846303793674;1614.7981502312211;1780.4213630570068;8085.716999905005;8565.871511927326;8593.871091933619;8890.77773055674;8940.105989401056;8768.69309574165;8893.377463577552;8893.466392016468;8897.510636914967;8901.376903616734;2417.2385698505004;2432.74456182101;2440.865752383618;2445.3397582652674;2446.22943772711;2361.445060410802;2398.688170537828;2410.8794560272004;2412.7949124324455;2415.45652228249;2364.9645255321184;2371.3241726108063;2371.774681405264;2415.2029830156093;2418.4800267942387;2325.627899536083;2340.20433052762;2341.040173528845;2346.9178578749747;2373.8813059347135;2297.9885100574556;2298.4598619324447;2313.0400883633274;2316.4324740438533;2321.5240875620457;8553.187447192508;8723.084076172037;8828.911710882872;8875.778105547348;8877.201051905295;5156.458571849939;5350.063738845686;5352.143657014859;5357.464253574651;5366.70483123428;3319.203391186122;3332.583427071616;3344.615369232545;3362.7045495414386;3390.271091715293;1233.2600439736177;1249.4756397195497;1260.6974326161746;1263.6145975477475;1279.7376537809728;11842.822357664556;11868.287902725864;11900.821487677606;11945.581904633384;12002.879971200264;4241.3637954307105;4373.650107991353;4582.060677561092;4589.426321709786;4616.907661846744;9478.146966773023;9481.810363792685;9482.336236463381;9482.810343793224;9489.478078705737;5223.190405487156;5225.529702326809;5229.790808367623;5240.240165176105;5241.685498870003;4294.914101717948;4732.550407711262;4884.145274576935;4895.534924182197;4900.828471003498;3807.1433927366675;3826.311263972512;3955.3275943089743;3964.781936993493;3987.8404863805704;1171.8769529199483;1175.7953836556458;1195.8325834383193;1198.5026214121217;1221.828943947848;784.1061190243128;845.9534725590029;931.7391130483476;932.1470854168496;947.8388673925449;5657.094864821691;5739.397363276879;5760;5825.592208545361;5826.126081087871;956.9569169605164;972.4991629310911;987.151050096916;988.906053924876;1038.693585392311;3826.674732647756;3966.6033396660105;4012.879613611596;4020.4572382728543;4088.182363527247;10486.790264194673;10923.508442120125;10949.616763413402;10956.28784129029;10959.945200274107;9680.515974201262;10038.397696138256;10042.297039207331;10840.78318433627;10841.512131954081;7869.0950540688555;8226.724857647074;8252.546109963889;8259.38054645904;8271.503709777433;5695.316562012585;5709;5749.7125143741805;5768.682722450306;5822.94177058224;9643.421394716339;9823.459709716035;9831.705048848546;9844.114029737359;9907;9431.339806213498;9800.705978820646;9806.215502759906;10088.293819432864;10097.848532272168;7449.478536502393;7631.1605723371495;7969.641366138421;8269.173082691683;8382.203690649378;8313.750587482386;8449.662013519635;8589.785255368666;8592.140785921358;8597.484150950962;7557.659905304165;7622.123455802432;7683.500572462772;7796.649150788115;7802;7335.926640733524;7517.060367454068;7585.558743838653;7600.46796724224;7622.199669034671;6821.317868213139;6951.304869513008;6961.095057642474;6966.860662786615;6970.268121847133;4796.616270698266;4803.95196048049;4810.542998415145;4918.458969513422;4948.529889660476;5000.349954506037;5074.619403544675;5131.461196574306;5166.844994650167;5210.6613070150315 23:52:50 INFO - PROCESS | 11723 | |4;prototype.html;332.3595102784359;338.8424382662062;339.9541061956636;340.16319853161224;343.59627437760656;5231.346081739783;5292.417834038252;5360.490753378428;5412.512873841349;5421.322334708161;5223.529882310591;5238.7642556084975;5244;5272.657277276974;5279.1817268323475;4115.238680844053;4143.067809742806;4144.109016561439;4153.626173644371;4235.788210589473;3938.4289278054666;4071.246819338417;4203.558626344236;4227.598378154085;4243.469566304212;4070.9185816283657;4072;4072.5112986441522;4084.81618327176;4088.3867419886956;4044.979775101135;4070.229450189177;4072.9796351018354;4106.77412742299;4130.607592278729;3619.9683090319395;3632.6185750496084;3638.181409182939;3644.287185023035;3652.433872749728;5025.070361983045;5099.761651351419;5113.181890897438;5137.0496458154985;5142.871428214287;4619.630429565626;4661.743604101773;4708.764561771932;4710.081534100852;4720.291956206562;5421.21392398104;5439.782408703647;5445.373782015079;5478.91781623276;5481.834675303273;3769.8869033929027;3920.3335432976464;3924.2347742190286;3945.5462621798574;3946.2502124596235;5691.613489973501;5723.399043100498;5728.942710572925;5745.299709136699;5746.54027677789;4095.28332541804;4114.930118169297;4131.731437456556;4137.627613514738;4143.482064741907;4054.0270335119358;4119.9176016479505;4131.5042194936195;4148.979255103765;4180.519240287406;4658.930116048262;4684.203685373494;4686.835960741358;4688.320193571913;4709.434867815884;5544.669279372922;5586.35756887955;5598.412166722435;5604.851005543936;5622.85942851432;1362.6797702539895;1363.1275983370651;1386.6533366658336;1400.4958215042577;1405.6907480354305;942.8397172480695;946.8532377481364;981.1267971505366;981.2738573455591;989.1345073061071;5221.7128057956415;5237.3453318335205;5259.737013149327;5309.495597918191;5310.230016647642;5520.199571062173;5541.4483944495605;5545.584081193927;5562.777488900399;5605.159226116034;5070.771815268322;5236.397814251333;5243.239730239094;5280.260763493114;5317.2024196370085;2953.586497890297;3001.159675290922;3001.6097907271915;3001.6998300169807;3002.714742099497;5854.209681692917;5862.648241105548;5869.853253668607;5881.3530511643685;5956.540647541294;5637.577181711306;5741.540676745851;5775.740091695884;5805.622634528742;5812.273465816773;5779.682117483495;5823.446772556685;5829.795957141479;5830.679312637845;5856.941430585724;5416.7562459688625;5583.497485226187;5639.8590035249445;5683.318001839806;5706.373683500183;5584.357798853184;5591.75678106689;5610.915836262541;5613.971930140323;5615.697563998741;5838.649681019152;5912.320083190488;5913.438223368773;5914.792982245601;5917.171595976481;3929.980350098231;4082.3264161413035;4107.137501124797;4108.4864391951005;4115.8971025724595;5348.465153484621;5557.221988921635;5609.775608975595;5641.294838145232;5644.6330988485615;5339.946600533945;5506.201600767947;5525.806596769255;5543.556515478833;5582.385937546947;5515.227868098389;5552.305961754781;5568.691357530896;5578.30271216098;5591.916121258266;5261.210818377274;5447.863803404946;5458.4814442627885;5535.8892822144135;5547.722613869371;5531.197976293495;5533.861653458695;5536.252605898152;5545.972270138624;5557.277553917965;5416.945830541802;5439;5445.727713614383;5497.835064948058;5520.503154716095 23:52:50 INFO - PROCESS | 11723 | |5;yui.html;801.3068695578323;805.7623001214641;826.2563692676587;826.5371392020469;840.8066144786703;15849.603759905995;15863.524094277162;16268.34926602936;16685.91657041716;16770.32918683251;15416.3833446662;15530.84469155308;15597.454089106883;15634.921825390857;15653.295601697922;771.2133623703819;783.2246076384396;785.3599316556988;786.5909726941986;786.8662327404355;651.9967400162992;767.4167632599209;784.19228194959;798.0981490915258;803.7186984555417;834.3492076180589;835.995820020899;838.375410319313;839.4585492357426;840;833.8207285433631;833.9291160251325;834.0450184538669;835.9916400835974;836.0093289451958;496.7019788127131;501.8444282272507;594.4531031451075;598.9041753319492;606.9089636554552;14413.207273599948;14442.566722998326;14443.78334324986;14448.988570800047;14467.71064578713;13954.860451395458;14543;14593.416263349452;15005;15203.847961520354;13141.934290328487;13261.27063011534;13475.595732127953;13492.12301200419;14011.159330440207;4425.3140763181755;4441.75570343631;4472.485664148599;4474.82100715971;4553.840615578472;85345.57327213325;85670.57164714199;85687;86529.56735216346;87413.56293218557;10398.376097434179;10895.492818226845;11099.667009989713;11207;11431.31412115259;18218.45344639663;18249.087545622664;18259.360922367654;18269.45191644253;18382;8216.589170541569;8375.664973400995;8383.8323233535;8449.66201351939;8451.619677114544;4748.216544270226;4839.903201935942;4911.8280860169725;4952;5156.587473002151;3290.4735242361107;3442.0706409269355;3447.3450044491465;3447.3967055765143;3447.482877568385;602.6534742523066;608.2093278737624;615.0528186592597;615.3231445410013;628.9874202515924;561.758652574642;567.1492760858712;609.1684850179473;637.4199478474566;686.5674624986326;9763.365381250196;10167.389956602627;10210.336328138646;10259.435731034864;10348.844767328495;596.4244504053522;605.794030029792;633.6134957675814;642.2838535033404;681.8806708825936;4710.175719249118;5109.412417571953;5460.262864513319;5489.835304940858;5627.746751396197;120029.39985300192;124298;124750;125082;125356.37321813333;103616.48191759143;104662.4766876176;106629;110059;111368;94405;95831.52084239674;96452.51773741227;98214;99592.50203749079;10032.448215347935;10113.747156321151;10122.645707400501;10339.741506462098;10352.482375881327;49759.751201243766;51069.489305107956;51810.22284665658;52178.478215217365;52967.47032529779;71536.64231679017;78483;78611.60694196721;79759.60120199595;81319;13315.467381305027;13432.597022089352;13597.320133993459;13630.659233519242;14082.22547759842;13671.17972921628;13812.171121087089;14820.555383338517;15129.848701512845;15396.615084622974;14062.718745625234;14224;14265.42938282457;14433.134011959317;14731.26343682833;13789.931050344683;14014.649633759238;14412.279386030446;14506.854931450973;15039.540905591557;13865.306734663429;13874.89000879907;14184.432622694976;14305.856941430453;14704.926475367554;11992.40037998114;12008.39958002114;12018.819717704417;12418.316992565495;12543.874561254635;11373.260738052;12312.384380781104;12393.194442361219;12539.184952978027;12784.6803829905 23:52:50 INFO - PROCESS | 11723 | __end_tp_report 23:52:50 INFO - PROCESS | 11723 | __start_cc_report 23:52:50 INFO - PROCESS | 11723 | _x_x_mozilla_cycle_collect,943 23:52:50 INFO - PROCESS | 11723 | __end_cc_report 23:52:50 INFO - PROCESS | 11723 | __startTimestamp1472799170749__endTimestamp 23:52:50 INFO - PROCESS | 11723 | 23:52:50 INFO - PROCESS | 11723 | ------- Summary: start ------- 23:52:50 INFO - PROCESS | 11723 | Number of tests: 6 23:52:50 INFO - PROCESS | 11723 | 23:52:50 INFO - PROCESS | 11723 | [#0] dojo.html Cycles:165 Average:5228.26 Median:5418.59 stddev:579.76 (10.7%) stddev-sans-first:554.91 23:52:50 INFO - PROCESS | 11723 | Values: 3014.1 3015.7 3041.9 3062.3 3089.9 5162.1 5162.9 5236.4 5263.2 5295.8 5173.4 5237.0 5257.2 5283.8 5354.8 4720.2 4731.1 4771.4 4806.7 4827.0 4804.7 4839.0 4955.5 4964.2 4967.7 4881.9 4902.8 4922.3 4925.6 4960.3 4684.3 4693.0 4721.5 4777.0 4861.3 4707.1 4717.6 4718.8 4735.2 4775.6 5242.6 5249.8 5258.2 5293.6 5298.4 5441.7 5550.8 5597.2 5604.5 5622.2 5588.5 5656.0 5663.8 5665.5 5672.4 5270.8 5275.9 5280.3 5280.6 5281.4 5638.0 5650.0 5688.0 5693.3 5810.9 5500.0 5507.3 5512.3 5512.4 5513.6 5579.4 5579.6 5583.6 5589.0 5598.2 5433.3 5500.3 5540.8 5547.7 5634.1 5581.3 5591.7 5592.2 5593.7 5599.1 4349.8 4353.4 4360.4 4370.7 4371.0 3851.4 3857.1 3891.8 3915.0 3979.2 5301.8 5308.0 5310.0 5314.7 5340.6 5565.2 5616.7 5618.2 5625.3 5627.2 5210.2 5268.7 5323.0 5331.4 5394.3 4848.7 4863.9 4864.0 4867.7 4918.8 5864.8 5870.5 5882.3 5884.2 5885.6 5516.4 5621.7 5681.2 5684.9 5778.4 5860.0 5873.0 5873.8 5874.3 5875.3 5613.6 5618.2 5620.7 5620.8 5622.5 5450.3 5490.7 5589.4 5611.3 5671.8 5466.1 5482.3 5483.3 5507.8 5508.3 5414.1 5455.5 5469.6 5471.1 5528.5 5347.6 5407.9 5413.2 5419.2 5522.9 5478.2 5508.2 5510.5 5516.7 5522.4 5398.1 5398.8 5399.1 5418.6 5475.1 23:52:50 INFO - PROCESS | 11723 | 23:52:50 INFO - PROCESS | 11723 | [#1] ext.html Cycles:180 Average:55985.06 Median:36829.54 stddev:107981.96 (293.2%) stddev-sans-first:108204.68 23:52:50 INFO - PROCESS | 11723 | Values: 556.5 595.3 612.4 627.3 627.8 32404.8 42848.4 43627.6 43726.3 43780.6 46070.3 46599.0 46800.0 46811.5 46914.5 8953.6 9137.4 9153.5 9154.3 9161.4 8357.7 10748.5 10989.2 10991.6 11217.6 10925.1 11022.9 11037.4 11043.6 11054.3 10913.9 11002.8 11009.7 11010.6 11040.3 10672.6 10719.2 10792.5 10856.1 10862.1 43255.6 43433.6 43560.0 43670.6 43935.0 3309.9 3512.4 3710.1 3763.5 4159.4 32483.4 32859.3 33390.4 33498.7 34693.7 4079.9 4299.1 4324.9 4396.3 4482.6 232419.8 232592.0 232662.0 233441.0 234514.0 61149.9 62015.4 62032.7 62150.7 62199.4 36140.6 36235.0 36812.1 64353.7 64562.4 15262.1 15351.5 15356.7 15363.4 15376.7 11687.4 11927.3 12169.7 12263.9 12279.3 18923.2 19454.2 19478.2 19488.8 19551.0 6951.3 7017.9 7089.2 7163.9 7188.2 952.5 1024.5 1060.5 1084.6 1093.2 31928.5 32502.0 32744.0 33086.5 33413.5 1117.9 1148.2 1148.4 1164.4 1201.6 15832.3 16863.5 16955.7 17008.3 17365.3 520337.0 528846.0 529974.0 530344.0 531484.0 58345.4 59023.4 59084.0 59094.7 59099.0 1192.9 1311.4 1327.8 1361.1 1370.9 31080.7 32708.0 33253.8 33507.8 33812.3 50404.0 50934.7 50939.2 50941.7 50951.7 402679.0 403746.0 404333.0 405327.0 405530.0 27903.7 28925.4 29006.6 30114.2 30143.4 48042.5 48177.0 48890.0 48907.8 49944.0 39116.2 39344.8 40250.0 40593.6 42094.8 40386.6 40694.0 40871.4 42089.6 42264.4 38984.8 39501.6 40979.8 41608.4 42439.4 32559.3 36479.3 36847.0 37041.8 37864.0 28215.2 28403.4 28539.0 28541.0 28633.0 23:52:50 INFO - PROCESS | 11723 | 23:52:50 INFO - PROCESS | 11723 | [#2] jquery.html Cycles:180 Average:29291.04 Median:396.67 stddev:78756.66 (19854.5%) stddev-sans-first:78947.67 23:52:50 INFO - PROCESS | 11723 | Values: 377.0 393.5 394.9 398.4 422.4 16117.8 19226.9 19292.5 19495.5 20068.3 18948.0 19094.1 19237.5 19417.5 19835.4 5688.1 5857.5 5887.1 6472.6 6839.2 6821.9 6857.7 6858.5 6863.4 6891.1 6685.1 6863.2 6868.3 6891.8 6902.3 6698.0 6841.7 6872.2 6881.4 6917.1 6474.2 6502.2 6508.9 6509.2 6517.4 23618.0 23897.2 24201.5 24402.4 24468.9 2451.7 2584.6 2621.7 2708.0 2952.2 14218.7 14442.7 14883.1 15090.5 15163.3 1890.3 1904.6 1959.5 1996.8 2028.2 86188.6 91845.0 92648.0 92956.5 94610.0 13847.9 14034.7 14183.1 14219.6 14582.9 12393.3 21719.3 21790.3 21822.3 21855.2 7725.6 7870.4 7964.8 8175.3 8244.1 7873.3 7932.3 8161.6 8167.2 8222.0 4070.6 4166.6 4177.2 4298.1 4304.5 1918.5 1926.1 1957.7 1980.1 2013.6 841.6 888.1 945.6 966.3 974.3 17448.9 17983.8 18138.5 19560.9 19814.9 922.7 940.7 965.7 1007.5 1028.5 10227.2 10739.5 10834.9 10869.4 10880.1 455556.0 475775.0 480173.0 484302.0 486914.0 58596.7 91563.5 95013.0 97149.0 98097.0 958.1 977.2 997.4 997.8 1003.2 16721.1 16948.2 17444.2 17448.6 17451.2 42144.0 42920.8 43269.8 43390.0 44470.8 54932.5 55664.4 58691.0 58859.0 59699.0 7629.5 7758.8 7853.2 8115.4 8269.0 11630.3 13393.0 13452.9 13511.5 13529.3 11590.3 11595.4 11654.9 11693.5 12170.1 11148.6 11423.2 11673.7 11909.2 12282.2 11681.5 11714.7 12031.9 12107.6 12459.6 7900.8 8135.1 8178.8 8209.9 8342.9 11545.1 11734.1 11818.8 11820.3 12294.6 23:52:50 INFO - PROCESS | 11723 | 23:52:50 INFO - PROCESS | 11723 | [#3] mootools.html Cycles:180 Average:5707.29 Median:5161.65 stddev:3192.36 (61.8%) stddev-sans-first:3184.17 23:52:50 INFO - PROCESS | 11723 | Values: 1305.9 1452.2 1472.5 1614.8 1780.4 8085.7 8565.9 8593.9 8890.8 8940.1 8768.7 8893.4 8893.5 8897.5 8901.4 2417.2 2432.7 2440.9 2445.3 2446.2 2361.4 2398.7 2410.9 2412.8 2415.5 2365.0 2371.3 2371.8 2415.2 2418.5 2325.6 2340.2 2341.0 2346.9 2373.9 2298.0 2298.5 2313.0 2316.4 2321.5 8553.2 8723.1 8828.9 8875.8 8877.2 5156.5 5350.1 5352.1 5357.5 5366.7 3319.2 3332.6 3344.6 3362.7 3390.3 1233.3 1249.5 1260.7 1263.6 1279.7 11842.8 11868.3 11900.8 11945.6 12002.9 4241.4 4373.7 4582.1 4589.4 4616.9 9478.1 9481.8 9482.3 9482.8 9489.5 5223.2 5225.5 5229.8 5240.2 5241.7 4294.9 4732.6 4884.1 4895.5 4900.8 3807.1 3826.3 3955.3 3964.8 3987.8 1171.9 1175.8 1195.8 1198.5 1221.8 784.1 846.0 931.7 932.1 947.8 5657.1 5739.4 5760.0 5825.6 5826.1 957.0 972.5 987.2 988.9 1038.7 3826.7 3966.6 4012.9 4020.5 4088.2 10486.8 10923.5 10949.6 10956.3 10959.9 9680.5 10038.4 10042.3 10840.8 10841.5 7869.1 8226.7 8252.5 8259.4 8271.5 5695.3 5709.0 5749.7 5768.7 5822.9 9643.4 9823.5 9831.7 9844.1 9907.0 9431.3 9800.7 9806.2 10088.3 10097.8 7449.5 7631.2 7969.6 8269.2 8382.2 8313.8 8449.7 8589.8 8592.1 8597.5 7557.7 7622.1 7683.5 7796.6 7802.0 7335.9 7517.1 7585.6 7600.5 7622.2 6821.3 6951.3 6961.1 6966.9 6970.3 4796.6 4804.0 4810.5 4918.5 4948.5 5000.3 5074.6 5131.5 5166.8 5210.7 23:52:50 INFO - PROCESS | 11723 | 23:52:50 INFO - PROCESS | 11723 | [#4] prototype.html Cycles:180 Average:4653.93 Median:5309.86 stddev:1363.37 (25.7%) stddev-sans-first:1328.05 23:52:50 INFO - PROCESS | 11723 | Values: 332.4 338.8 340.0 340.2 343.6 5231.3 5292.4 5360.5 5412.5 5421.3 5223.5 5238.8 5244.0 5272.7 5279.2 4115.2 4143.1 4144.1 4153.6 4235.8 3938.4 4071.2 4203.6 4227.6 4243.5 4070.9 4072.0 4072.5 4084.8 4088.4 4045.0 4070.2 4073.0 4106.8 4130.6 3620.0 3632.6 3638.2 3644.3 3652.4 5025.1 5099.8 5113.2 5137.0 5142.9 4619.6 4661.7 4708.8 4710.1 4720.3 5421.2 5439.8 5445.4 5478.9 5481.8 3769.9 3920.3 3924.2 3945.5 3946.3 5691.6 5723.4 5728.9 5745.3 5746.5 4095.3 4114.9 4131.7 4137.6 4143.5 4054.0 4119.9 4131.5 4149.0 4180.5 4658.9 4684.2 4686.8 4688.3 4709.4 5544.7 5586.4 5598.4 5604.9 5622.9 1362.7 1363.1 1386.7 1400.5 1405.7 942.8 946.9 981.1 981.3 989.1 5221.7 5237.3 5259.7 5309.5 5310.2 5520.2 5541.4 5545.6 5562.8 5605.2 5070.8 5236.4 5243.2 5280.3 5317.2 2953.6 3001.2 3001.6 3001.7 3002.7 5854.2 5862.6 5869.9 5881.4 5956.5 5637.6 5741.5 5775.7 5805.6 5812.3 5779.7 5823.4 5829.8 5830.7 5856.9 5416.8 5583.5 5639.9 5683.3 5706.4 5584.4 5591.8 5610.9 5614.0 5615.7 5838.6 5912.3 5913.4 5914.8 5917.2 3930.0 4082.3 4107.1 4108.5 4115.9 5348.5 5557.2 5609.8 5641.3 5644.6 5339.9 5506.2 5525.8 5543.6 5582.4 5515.2 5552.3 5568.7 5578.3 5591.9 5261.2 5447.9 5458.5 5535.9 5547.7 5531.2 5533.9 5536.3 5546.0 5557.3 5416.9 5439.0 5445.7 5497.8 5520.5 23:52:50 INFO - PROCESS | 11723 | 23:52:50 INFO - PROCESS | 11723 | [#5] yui.html Cycles:180 Average:22117.03 Median:3444.71 stddev:32607.26 (946.6%) stddev-sans-first:32659.45 23:52:50 INFO - PROCESS | 11723 | Values: 801.3 805.8 826.3 826.5 840.8 15849.6 15863.5 16268.3 16685.9 16770.3 15416.4 15530.8 15597.5 15634.9 15653.3 771.2 783.2 785.4 786.6 786.9 652.0 767.4 784.2 798.1 803.7 834.3 836.0 838.4 839.5 840.0 833.8 833.9 834.0 836.0 836.0 496.7 501.8 594.5 598.9 606.9 14413.2 14442.6 14443.8 14449.0 14467.7 13954.9 14543.0 14593.4 15005.0 15203.8 13141.9 13261.3 13475.6 13492.1 14011.2 4425.3 4441.8 4472.5 4474.8 4553.8 85345.6 85670.6 85687.0 86529.6 87413.6 10398.4 10895.5 11099.7 11207.0 11431.3 18218.5 18249.1 18259.4 18269.5 18382.0 8216.6 8375.7 8383.8 8449.7 8451.6 4748.2 4839.9 4911.8 4952.0 5156.6 3290.5 3442.1 3447.3 3447.4 3447.5 602.7 608.2 615.1 615.3 629.0 561.8 567.1 609.2 637.4 686.6 9763.4 10167.4 10210.3 10259.4 10348.8 596.4 605.8 633.6 642.3 681.9 4710.2 5109.4 5460.3 5489.8 5627.7 120029.4 124298.0 124750.0 125082.0 125356.4 103616.5 104662.5 106629.0 110059.0 111368.0 94405.0 95831.5 96452.5 98214.0 99592.5 10032.4 10113.7 10122.6 10339.7 10352.5 49759.8 51069.5 51810.2 52178.5 52967.5 71536.6 78483.0 78611.6 79759.6 81319.0 13315.5 13432.6 13597.3 13630.7 14082.2 13671.2 13812.2 14820.6 15129.8 15396.6 14062.7 14224.0 14265.4 14433.1 14731.3 13789.9 14014.6 14412.3 14506.9 15039.5 13865.3 13874.9 14184.4 14305.9 14704.9 11992.4 12008.4 12018.8 12418.3 12543.9 11373.3 12312.4 12393.2 12539.2 12784.7 23:52:50 INFO - PROCESS | 11723 | -------- Summary: end -------- 23:52:50 INFO - PROCESS | 11723 | 23:52:51 INFO - TEST-INFO | 11723: exit 0 23:52:51 INFO - TEST-OK | dromaeo_css | took 1116068ms 23:52:51 INFO - TEST-START | kraken 23:52:51 INFO - operating with platform_type : linux_ 23:52:51 INFO - Initialising browser for kraken test... 23:52:51 INFO - TEST-INFO | started process 12033 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKu4lOA/profile http://localhost:39062/getInfo.html) 23:52:56 INFO - PROCESS | 12033 | __metrics Screen width/height:1600/1200 23:52:56 INFO - PROCESS | 12033 | colorDepth:24 23:52:56 INFO - PROCESS | 12033 | Browser inner width/height: 1024/697 23:52:56 INFO - PROCESS | 12033 | __metrics 23:52:56 INFO - PROCESS | 12033 | 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" 23:52:56 INFO - PROCESS | 12033 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:52:57 INFO - PROCESS | 12033 | console.error: PushService: 23:52:57 INFO - PROCESS | 12033 | stateChangeProcessEnqueue: Error transitioning state 23:52:57 INFO - PROCESS | 12033 | UnknownError 23:52:58 INFO - TEST-INFO | 12033: exit 0 23:52:58 INFO - Browser initialized. 23:52:58 INFO - Running cycle 1/1 for kraken test... 23:52:58 INFO - TEST-INFO | started process 12114 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKu4lOA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:53:10 INFO - PROCESS | 12114 | RSS: Main: 179261440 23:53:10 INFO - PROCESS | 12114 | 23:53:12 INFO - PROCESS | 12114 | Cycle 1(1): loaded http://localhost:39062/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39062/tests/kraken/driver.html?testName=audio-beat-detection) 23:53:13 INFO - PROCESS | 12114 | RSS: Main: 234201088 23:53:13 INFO - PROCESS | 12114 | 23:53:16 INFO - PROCESS | 12114 | Cycle 1(1): loaded http://localhost:39062/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39062/tests/kraken/driver.html?testName=audio-dft) 23:53:16 INFO - PROCESS | 12114 | RSS: Main: 224124928 23:53:16 INFO - PROCESS | 12114 | 23:53:19 INFO - PROCESS | 12114 | Cycle 1(1): loaded http://localhost:39062/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39062/tests/kraken/driver.html?testName=audio-fft) 23:53:20 INFO - PROCESS | 12114 | RSS: Main: 300953600 23:53:20 INFO - PROCESS | 12114 | 23:53:22 INFO - PROCESS | 12114 | Cycle 1(1): loaded http://localhost:39062/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39062/tests/kraken/driver.html?testName=audio-oscillator) 23:53:23 INFO - PROCESS | 12114 | RSS: Main: 212463616 23:53:23 INFO - PROCESS | 12114 | 23:53:25 INFO - PROCESS | 12114 | Cycle 1(1): loaded http://localhost:39062/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39062/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:53:25 INFO - PROCESS | 12114 | RSS: Main: 213680128 23:53:25 INFO - PROCESS | 12114 | 23:53:28 INFO - PROCESS | 12114 | Cycle 1(1): loaded http://localhost:39062/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39062/tests/kraken/driver.html?testName=imaging-darkroom) 23:53:29 INFO - PROCESS | 12114 | RSS: Main: 252174336 23:53:29 INFO - PROCESS | 12114 | 23:53:32 INFO - PROCESS | 12114 | Cycle 1(1): loaded http://localhost:39062/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39062/tests/kraken/driver.html?testName=imaging-desaturate) 23:53:33 INFO - PROCESS | 12114 | RSS: Main: 250863616 23:53:33 INFO - PROCESS | 12114 | 23:53:36 INFO - PROCESS | 12114 | Cycle 1(1): loaded http://localhost:39062/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39062/tests/kraken/driver.html?testName=json-parse-financial) 23:53:36 INFO - PROCESS | 12114 | RSS: Main: 250785792 23:53:36 INFO - PROCESS | 12114 | 23:53:38 INFO - PROCESS | 12114 | Cycle 1(1): loaded http://localhost:39062/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39062/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:53:38 INFO - PROCESS | 12114 | RSS: Main: 214118400 23:53:38 INFO - PROCESS | 12114 | 23:53:40 INFO - PROCESS | 12114 | Cycle 1(1): loaded http://localhost:39062/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39062/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:53:41 INFO - PROCESS | 12114 | RSS: Main: 220962816 23:53:41 INFO - PROCESS | 12114 | 23:53:43 INFO - PROCESS | 12114 | Cycle 1(1): loaded http://localhost:39062/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39062/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:53:44 INFO - PROCESS | 12114 | RSS: Main: 222183424 23:53:44 INFO - PROCESS | 12114 | 23:53:46 INFO - PROCESS | 12114 | Cycle 1(1): loaded http://localhost:39062/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39062/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:53:47 INFO - PROCESS | 12114 | RSS: Main: 222912512 23:53:47 INFO - PROCESS | 12114 | 23:53:50 INFO - PROCESS | 12114 | Cycle 1(1): loaded http://localhost:39062/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39062/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:53:50 INFO - PROCESS | 12114 | RSS: Main: 221622272 23:53:50 INFO - PROCESS | 12114 | 23:53:52 INFO - PROCESS | 12114 | Cycle 1(1): loaded http://localhost:39062/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39062/tests/kraken/driver.html?testName=ai-astar) 23:53:52 INFO - PROCESS | 12114 | RSS: Main: 272101376 23:53:52 INFO - PROCESS | 12114 | 23:53:52 INFO - PROCESS | 12114 | __start_tp_report 23:53:52 INFO - PROCESS | 12114 | _x_x_mozilla_page_load 23:53:52 INFO - PROCESS | 12114 | _x_x_mozilla_page_load_details 23:53:52 INFO - PROCESS | 12114 | |i|pagename|runs| 23:53:52 INFO - PROCESS | 12114 | |0;ai-astar;115;114;118;112;114;122;113;111;111;127 23:53:52 INFO - PROCESS | 12114 | |1;audio-beat-detection;155;120;143;183;118;156;145;120;184;119 23:53:52 INFO - PROCESS | 12114 | |2;audio-dft;161;161;162;161;161;163;161;163;162;163 23:53:52 INFO - PROCESS | 12114 | |3;audio-fft;76;76;76;174;77;77;77;76;171;75 23:53:52 INFO - PROCESS | 12114 | |4;audio-oscillator;82;83;144;82;82;82;150;82;81;148 23:53:52 INFO - PROCESS | 12114 | |5;imaging-gaussian-blur;116;117;116;117;116;116;118;117;117;117 23:53:52 INFO - PROCESS | 12114 | |6;imaging-darkroom;148;147;149;148;148;147;147;147;147;147 23:53:52 INFO - PROCESS | 12114 | |7;imaging-desaturate;95;95;94;95;95;94;96;96;95;96 23:53:52 INFO - PROCESS | 12114 | |8;json-parse-financial;52;50;51;51;53;51;53;52;52;55 23:53:52 INFO - PROCESS | 12114 | |9;json-stringify-tinderbox;61;61;61;61;61;61;60;62;62;61 23:53:52 INFO - PROCESS | 12114 | |10;stanford-crypto-aes;82;80;84;79;79;88;81;78;78;79 23:53:52 INFO - PROCESS | 12114 | |11;stanford-crypto-ccm;126;129;123;125;128;125;124;122;168;128 23:53:52 INFO - PROCESS | 12114 | |12;stanford-crypto-pbkdf2;162;167;163;168;163;166;168;165;163;163 23:53:52 INFO - PROCESS | 12114 | |13;stanford-crypto-sha256-iterative;67;65;65;64;65;67;65;65;63;70 23:53:52 INFO - PROCESS | 12114 | __end_tp_report 23:53:52 INFO - PROCESS | 12114 | __start_cc_report 23:53:52 INFO - PROCESS | 12114 | _x_x_mozilla_cycle_collect,1688 23:53:52 INFO - PROCESS | 12114 | __end_cc_report 23:53:52 INFO - PROCESS | 12114 | __startTimestamp1472799232651__endTimestamp 23:53:52 INFO - PROCESS | 12114 | 23:53:52 INFO - PROCESS | 12114 | ------- Summary: start ------- 23:53:52 INFO - PROCESS | 12114 | Number of tests: 14 23:53:52 INFO - PROCESS | 12114 | 23:53:52 INFO - PROCESS | 12114 | [#0] ai-astar Cycles:10 Average:115.70 Median:114.50 stddev:5.21 (4.5%) stddev-sans-first:5.52 23:53:52 INFO - PROCESS | 12114 | Values: 115.0 114.0 118.0 112.0 114.0 122.0 113.0 111.0 111.0 127.0 23:53:52 INFO - PROCESS | 12114 | 23:53:52 INFO - PROCESS | 12114 | [#1] audio-beat-detection Cycles:10 Average:144.30 Median:150.00 stddev:25.47 (17.0%) stddev-sans-first:26.72 23:53:52 INFO - PROCESS | 12114 | Values: 155.0 120.0 143.0 183.0 118.0 156.0 145.0 120.0 184.0 119.0 23:53:52 INFO - PROCESS | 12114 | 23:53:52 INFO - PROCESS | 12114 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 23:53:52 INFO - PROCESS | 12114 | Values: 161.0 161.0 162.0 161.0 161.0 163.0 161.0 163.0 162.0 163.0 23:53:52 INFO - PROCESS | 12114 | 23:53:52 INFO - PROCESS | 12114 | [#3] audio-fft Cycles:10 Average:95.50 Median:76.00 stddev:40.59 (53.4%) stddev-sans-first:42.44 23:53:52 INFO - PROCESS | 12114 | Values: 76.0 76.0 76.0 174.0 77.0 77.0 77.0 76.0 171.0 75.0 23:53:52 INFO - PROCESS | 12114 | 23:53:52 INFO - PROCESS | 12114 | [#4] audio-oscillator Cycles:10 Average:101.60 Median:82.00 stddev:31.60 (38.5%) stddev-sans-first:32.71 23:53:52 INFO - PROCESS | 12114 | Values: 82.0 83.0 144.0 82.0 82.0 82.0 150.0 82.0 81.0 148.0 23:53:52 INFO - PROCESS | 12114 | 23:53:52 INFO - PROCESS | 12114 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 23:53:52 INFO - PROCESS | 12114 | Values: 116.0 117.0 116.0 117.0 116.0 116.0 118.0 117.0 117.0 117.0 23:53:52 INFO - PROCESS | 12114 | 23:53:52 INFO - PROCESS | 12114 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 23:53:52 INFO - PROCESS | 12114 | Values: 148.0 147.0 149.0 148.0 148.0 147.0 147.0 147.0 147.0 147.0 23:53:52 INFO - PROCESS | 12114 | 23:53:52 INFO - PROCESS | 12114 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 23:53:52 INFO - PROCESS | 12114 | Values: 95.0 95.0 94.0 95.0 95.0 94.0 96.0 96.0 95.0 96.0 23:53:52 INFO - PROCESS | 12114 | 23:53:52 INFO - PROCESS | 12114 | [#8] json-parse-financial Cycles:10 Average:52.00 Median:52.00 stddev:1.41 (2.7%) stddev-sans-first:1.50 23:53:52 INFO - PROCESS | 12114 | Values: 52.0 50.0 51.0 51.0 53.0 51.0 53.0 52.0 52.0 55.0 23:53:52 INFO - PROCESS | 12114 | 23:53:52 INFO - PROCESS | 12114 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:61.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 23:53:52 INFO - PROCESS | 12114 | Values: 61.0 61.0 61.0 61.0 61.0 61.0 60.0 62.0 62.0 61.0 23:53:52 INFO - PROCESS | 12114 | 23:53:52 INFO - PROCESS | 12114 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:80.50 stddev:3.16 (3.9%) stddev-sans-first:3.32 23:53:52 INFO - PROCESS | 12114 | Values: 82.0 80.0 84.0 79.0 79.0 88.0 81.0 78.0 78.0 79.0 23:53:52 INFO - PROCESS | 12114 | 23:53:52 INFO - PROCESS | 12114 | [#11] stanford-crypto-ccm Cycles:10 Average:129.80 Median:127.00 stddev:13.61 (10.7%) stddev-sans-first:14.37 23:53:52 INFO - PROCESS | 12114 | Values: 126.0 129.0 123.0 125.0 128.0 125.0 124.0 122.0 168.0 128.0 23:53:52 INFO - PROCESS | 12114 | 23:53:52 INFO - PROCESS | 12114 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.80 Median:165.50 stddev:2.30 (1.4%) stddev-sans-first:2.20 23:53:52 INFO - PROCESS | 12114 | Values: 162.0 167.0 163.0 168.0 163.0 166.0 168.0 165.0 163.0 163.0 23:53:52 INFO - PROCESS | 12114 | 23:53:52 INFO - PROCESS | 12114 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:65.00 stddev:1.96 (3.0%) stddev-sans-first:2.01 23:53:52 INFO - PROCESS | 12114 | Values: 67.0 65.0 65.0 64.0 65.0 67.0 65.0 65.0 63.0 70.0 23:53:52 INFO - PROCESS | 12114 | -------- Summary: end -------- 23:53:52 INFO - PROCESS | 12114 | 23:53:53 INFO - TEST-INFO | 12114: exit 0 23:53:53 INFO - TEST-OK | kraken | took 62180ms 23:53:53 INFO - SUITE-END | took 1178s 23:53:54 INFO - Completed test suite (00:19:38) 23:53:54 INFO - javascript benchmark 23:53:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3014.065639651708, 3015.6531998820137, 3041.9391612167756, 3062.3262882165914, 3089.9073027809172, 5162.070827251093, 5162.948370516294, 5236.371635403757, 5263.236830659557, 5295.841124766253, 5173.379194496656, 5237.031149237384, 5257.158854583267, 5283.841484755454, 5354.839354819352, 4720.197566413718, 4731.101090792738, 4771.42742870856, 4806.6875653082525, 4827.0, 4804.711717296956, 4838.951610483903, 4955.529224723646, 4964.205727083649, 4967.70193788372, 4881.902361952741, 4902.8038878444995, 4922.26166075088, 4925.556699897009, 4960.280759289919, 4684.32077348786, 4692.976535117303, 4721.504242054569, 4777.0, 4861.319415281863, 4707.082118986799, 4717.646176536739, 4718.811247550094, 4735.218688916325, 4775.594074503671, 5242.580593552545, 5249.816256431045, 5258.211268309746, 5293.57651387888, 5298.417174110845, 5441.673499590037, 5550.750216240239, 5597.216389705444, 5604.523615492688, 5622.156676498517, 5588.469095435927, 5655.971720141414, 5663.773449062032, 5665.461781130827, 5672.404397538282, 5270.789168433258, 5275.868103297448, 5280.287161233223, 5280.551153151987, 5281.445448227958, 5638.0, 5650.011248031578, 5687.976164290468, 5693.259876216065, 5810.912836307459, 5500.0, 5507.311586051744, 5512.255845460892, 5512.448755124456, 5513.58648101394, 5579.38626751057, 5579.609427340048, 5583.553315734732, 5589.0219211637805, 5598.188262701967, 5433.266509021231, 5500.339959204921, 5540.778368865281, 5547.667139971614, 5634.070378387521, 5581.330240371181, 5591.720413979285, 5592.217089607459, 5593.720313984284, 5599.1041433370465, 4349.782510874444, 4353.390525326457, 4360.4331436913, 4370.666946581323, 4371.041847758599, 3851.441540976543, 3857.1128640412303, 3891.7664940103687, 3914.9608503915165, 3979.184267225212, 5301.840944771663, 5307.9734601326745, 5309.973450132802, 5314.73426328682, 5340.572754179656, 5565.16522521625, 5616.747246373923, 5618.185363122325, 5625.268715067015, 5627.240322556484, 5210.244514545369, 5268.736563171826, 5323.015242180131, 5331.413544510101, 5394.271773310631, 4848.7090774553635, 4863.878403039882, 4864.0, 4867.659263851497, 4918.778654960463, 5864.794732184353, 5870.5010074144175, 5882.323532793698, 5884.205632239593, 5885.588008839341, 5516.448355164612, 5621.690807005491, 5681.204631351697, 5684.886302274014, 5778.393268706894, 5860.033094539353, 5872.970635146797, 5873.765049397976, 5874.295084589877, 5875.265591801025, 5613.607047506635, 5618.185363122406, 5620.74706638194, 5620.8032718856275, 5622.493975542221, 5450.31871016123, 5490.670559766427, 5589.357223919302, 5611.3266408031295, 5671.773129074791, 5466.098093814476, 5482.259894914136, 5483.287172667528, 5507.779688812563, 5508.338999320107, 5414.079606466831, 5455.481729235717, 5469.644473109235, 5471.097268950579, 5528.530074943514, 5347.572194224531, 5407.918881216863, 5413.160960051198, 5419.214213939035, 5522.861928451821, 5478.178273259043, 5508.20131080999, 5510.476504732044, 5516.696581688046, 5522.420145884625, 5398.13629819227, 5398.757055932414, 5399.109146990702, 5418.593605479526, 5475.09660905946], "value": 5189.851900807937, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.5325126893408, 595.2975488923071, 612.4120843989768, 627.3099590450505, 627.7834147219207, 32404.83797581012, 42848.35727464087, 43627.56372436275, 43726.34410483841, 43780.56219437805, 46070.30894536576, 46599.0, 46800.0, 46811.53188468114, 46914.530854691446, 8953.59708813105, 9137.406068605553, 9153.450792952412, 9154.267658587298, 9161.404508706913, 8357.665693372257, 10748.495210670513, 10989.175811814106, 10991.61529346473, 11217.607383741572, 10925.125989920787, 11022.889771102307, 11037.448127593629, 11043.558257669683, 11054.336739795597, 10913.890861091406, 11002.834957475645, 11009.669709908716, 11010.614628487965, 11040.282381645167, 10672.626458074008, 10719.249652524326, 10792.51433685486, 10856.077233435168, 10862.076723478514, 43255.56744432547, 43433.56566434327, 43560.0, 43670.56329436728, 43935.0, 3309.851056702454, 3512.420450625669, 3710.053936246267, 3763.4919285896326, 4159.396887451303, 32483.350332993443, 32859.34281314384, 33390.41865341902, 33498.6650133498, 34693.6530634693, 4079.9184016319805, 4299.07569872479, 4324.935125973113, 4396.318570621559, 4482.618977386926, 232419.8379008111, 232592.0, 232662.0, 233441.0, 234514.0, 61149.94250287468, 62015.37984620186, 62032.689836550526, 62150.68924655438, 62199.378006220264, 36140.63859361373, 36235.0, 36812.07969800723, 64353.678231609476, 64562.35437645658, 15262.084274943318, 15351.539453816404, 15356.692866142615, 15363.385464581515, 15376.692466150615, 11687.415629218674, 11927.284362938251, 12169.69575760613, 12263.877361226452, 12279.263244205198, 18923.24307027731, 19454.16722520927, 19478.247037302222, 19488.83219193409, 19550.965424337788, 6951.339622735832, 7017.89473157903, 7089.184743754534, 7163.89254161188, 7188.173360063555, 952.4951775558965, 1024.4877561219391, 1060.5492665617082, 1084.5770149641646, 1093.223811094132, 31928.521072183936, 32502.0, 32744.0, 33086.50370244448, 33413.498797518056, 1117.94969226385, 1148.2019996102795, 1148.3683973814368, 1164.371239530661, 1201.591458903977, 15832.28754706041, 16863.49409517692, 16955.745663815054, 17008.31966721342, 17365.30538778435, 520337.0, 528846.0, 529974.0, 530344.0, 531484.0, 58345.41654583485, 59023.40976590179, 59084.0, 59094.70452647709, 59099.0, 1192.8747481514315, 1311.3902035553513, 1327.8472975607929, 1361.1288775183891, 1370.917744935327, 31080.68919310778, 32708.0, 33253.83373083119, 33507.83246083754, 33812.3237535243, 50404.0, 50934.74532627313, 50939.235911460615, 50941.745291273306, 50951.74524127356, 402679.0, 403746.0, 404333.0, 405327.0, 405530.0, 27903.720962790114, 28925.421491570472, 29006.564901526915, 30114.24714382158, 30143.397132057675, 48042.5195748038, 48177.0, 48890.0, 48907.75546122246, 49944.0, 39116.2176756469, 39344.80327598344, 40250.0, 40593.59406405898, 42094.78952605218, 40386.596134038286, 40694.0, 40871.38692919549, 42089.57910420857, 42264.366034508894, 38984.80507597444, 39501.604983949794, 40979.795101024305, 41608.375874362515, 42439.36340954826, 32559.34881302408, 36479.27041459209, 36847.0, 37041.814790926954, 37864.0, 28215.15354539367, 28403.43193136167, 28539.0, 28541.0, 28633.0], "value": 20247.11452661057, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.9509963704718, 393.54742046646356, 394.9071968087499, 398.4302447500075, 422.39386480400606, 16117.83882161178, 19226.90386548067, 19292.51768705783, 19495.512612184702, 20068.297609583668, 18948.0, 19094.140763665633, 19237.519062023457, 19417.514562135955, 19835.404937851887, 5688.089905615113, 5857.531397488191, 5887.116932460122, 6472.579282346633, 6839.213490448587, 6821.931780682204, 6857.725690972356, 6858.485613579001, 6863.416609588191, 6891.1041564596535, 6685.13093297873, 6863.1764188297475, 6868.347506986854, 6891.827704307382, 6902.275261097588, 6698.028785826053, 6841.692123854438, 6872.244053154149, 6881.41507971823, 6917.100776898971, 6474.223093228796, 6502.219733631947, 6508.8698226035685, 6509.218893732783, 6517.380848819402, 23618.0, 23897.163599274118, 24201.515969680684, 24402.389940251458, 24468.877655611785, 2451.6812814334203, 2584.5993870949846, 2621.659184306047, 2708.0251109600526, 2952.2324195709057, 14218.715625687531, 14442.711145777026, 14883.107013579112, 15090.5472835814, 15163.317650705745, 1890.2533499267713, 1904.6381187574455, 1959.4709428454237, 1996.760388753359, 2028.2495476673726, 86188.56905715431, 91844.99999999933, 92648.0, 92956.53521732416, 94610.0, 13847.930760346335, 14034.719305613831, 14183.14901105937, 14219.573412797632, 14582.854171458363, 12393.318367489694, 21719.348419547438, 21790.346289611338, 21822.345329640135, 21855.235066772588, 7725.613719314012, 7870.409719271078, 7964.800879978047, 8175.305099066527, 8244.093149753522, 7873.25204105609, 7932.325752311002, 8161.63272652732, 8167.183281671785, 8222.0, 4070.5522392536795, 4166.6250037496775, 4177.248095342807, 4298.054428025829, 4304.526502084768, 1918.5395505078682, 1926.0658580588404, 1957.67698329774, 1980.059541649192, 2013.5771487987395, 841.6254766628914, 888.1074520107251, 945.645382981382, 966.2559828931824, 974.2644303550774, 17448.91275543614, 17983.820161798478, 18138.455846324632, 19560.902195488932, 19814.900925495567, 922.6955104815395, 940.7177846646116, 965.7392504023874, 1007.5466040281902, 1028.5320179318392, 10227.232957528215, 10739.516721747541, 10834.891651083546, 10869.40218287986, 10880.12958963281, 455556.0, 475775.0, 480173.0, 484302.0, 486914.0, 58596.70701646464, 91563.54218228866, 95013.0, 97149.0, 98097.0, 958.1281034258791, 977.2279898879948, 997.3616885193481, 997.7854761226226, 1003.1673710820002, 16721.080340581386, 16948.152592370086, 17444.21501032431, 17448.563785905455, 17451.214695338487, 42144.0, 42920.79676197199, 43269.78365108154, 43390.0, 44470.77764611286, 54932.450675492735, 55664.44335556593, 58691.0, 58859.0, 59699.0, 7629.54222746637, 7758.844823103619, 7853.175416581405, 8115.391345649218, 8269.0, 11630.302181869114, 13393.0, 13452.865471345161, 13511.527096551574, 13529.323533823466, 11590.304581725124, 11595.362255076052, 11654.88345116538, 11693.532258709896, 12170.087243456954, 11148.609798657008, 11423.200375973602, 11673.708157296136, 11909.166358354832, 12282.201656892274, 11681.532738690357, 11714.70713232176, 12031.939840300742, 12107.636770896886, 12459.626211213677, 7900.84198316042, 8135.064467586303, 8178.754637360888, 8209.876851847346, 8342.916570834213, 11545.134114941246, 11734.061275098142, 11818.82271765907, 11820.290782553075, 12294.631161065183], "value": 9621.342153190604, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1305.9216447013187, 1452.2158034661284, 1472.4846303793674, 1614.7981502312211, 1780.4213630570068, 8085.716999905005, 8565.871511927326, 8593.871091933619, 8890.77773055674, 8940.105989401056, 8768.69309574165, 8893.377463577552, 8893.466392016468, 8897.510636914967, 8901.376903616734, 2417.2385698505004, 2432.74456182101, 2440.865752383618, 2445.3397582652674, 2446.22943772711, 2361.445060410802, 2398.688170537828, 2410.8794560272004, 2412.7949124324455, 2415.45652228249, 2364.9645255321184, 2371.3241726108063, 2371.774681405264, 2415.2029830156093, 2418.4800267942387, 2325.627899536083, 2340.20433052762, 2341.040173528845, 2346.9178578749747, 2373.8813059347135, 2297.9885100574556, 2298.4598619324447, 2313.0400883633274, 2316.4324740438533, 2321.5240875620457, 8553.187447192508, 8723.084076172037, 8828.911710882872, 8875.778105547348, 8877.201051905295, 5156.458571849939, 5350.063738845686, 5352.143657014859, 5357.464253574651, 5366.70483123428, 3319.203391186122, 3332.583427071616, 3344.615369232545, 3362.7045495414386, 3390.271091715293, 1233.2600439736177, 1249.4756397195497, 1260.6974326161746, 1263.6145975477475, 1279.7376537809728, 11842.822357664556, 11868.287902725864, 11900.821487677606, 11945.581904633384, 12002.879971200264, 4241.3637954307105, 4373.650107991353, 4582.060677561092, 4589.426321709786, 4616.907661846744, 9478.146966773023, 9481.810363792685, 9482.336236463381, 9482.810343793224, 9489.478078705737, 5223.190405487156, 5225.529702326809, 5229.790808367623, 5240.240165176105, 5241.685498870003, 4294.914101717948, 4732.550407711262, 4884.145274576935, 4895.534924182197, 4900.828471003498, 3807.1433927366675, 3826.311263972512, 3955.3275943089743, 3964.781936993493, 3987.8404863805704, 1171.8769529199483, 1175.7953836556458, 1195.8325834383193, 1198.5026214121217, 1221.828943947848, 784.1061190243128, 845.9534725590029, 931.7391130483476, 932.1470854168496, 947.8388673925449, 5657.094864821691, 5739.397363276879, 5760.0, 5825.592208545361, 5826.126081087871, 956.9569169605164, 972.4991629310911, 987.151050096916, 988.906053924876, 1038.693585392311, 3826.674732647756, 3966.6033396660105, 4012.879613611596, 4020.4572382728543, 4088.182363527247, 10486.790264194673, 10923.508442120125, 10949.616763413402, 10956.28784129029, 10959.945200274107, 9680.515974201262, 10038.397696138256, 10042.297039207331, 10840.78318433627, 10841.512131954081, 7869.0950540688555, 8226.724857647074, 8252.546109963889, 8259.38054645904, 8271.503709777433, 5695.316562012585, 5709.0, 5749.7125143741805, 5768.682722450306, 5822.94177058224, 9643.421394716339, 9823.459709716035, 9831.705048848546, 9844.114029737359, 9907.0, 9431.339806213498, 9800.705978820646, 9806.215502759906, 10088.293819432864, 10097.848532272168, 7449.478536502393, 7631.1605723371495, 7969.641366138421, 8269.173082691683, 8382.203690649378, 8313.750587482386, 8449.662013519635, 8589.785255368666, 8592.140785921358, 8597.484150950962, 7557.659905304165, 7622.123455802432, 7683.500572462772, 7796.649150788115, 7802.0, 7335.926640733524, 7517.060367454068, 7585.558743838653, 7600.46796724224, 7622.199669034671, 6821.317868213139, 6951.304869513008, 6961.095057642474, 6966.860662786615, 6970.268121847133, 4796.616270698266, 4803.95196048049, 4810.542998415145, 4918.458969513422, 4948.529889660476, 5000.349954506037, 5074.619403544675, 5131.461196574306, 5166.844994650167, 5210.6613070150315], "value": 4595.965922425645, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.3595102784359, 338.8424382662062, 339.9541061956636, 340.16319853161224, 343.59627437760656, 5231.346081739783, 5292.417834038252, 5360.490753378428, 5412.512873841349, 5421.322334708161, 5223.529882310591, 5238.7642556084975, 5244.0, 5272.657277276974, 5279.1817268323475, 4115.238680844053, 4143.067809742806, 4144.109016561439, 4153.626173644371, 4235.788210589473, 3938.4289278054666, 4071.246819338417, 4203.558626344236, 4227.598378154085, 4243.469566304212, 4070.9185816283657, 4072.0, 4072.5112986441522, 4084.81618327176, 4088.3867419886956, 4044.979775101135, 4070.229450189177, 4072.9796351018354, 4106.77412742299, 4130.607592278729, 3619.9683090319395, 3632.6185750496084, 3638.181409182939, 3644.287185023035, 3652.433872749728, 5025.070361983045, 5099.761651351419, 5113.181890897438, 5137.0496458154985, 5142.871428214287, 4619.630429565626, 4661.743604101773, 4708.764561771932, 4710.081534100852, 4720.291956206562, 5421.21392398104, 5439.782408703647, 5445.373782015079, 5478.91781623276, 5481.834675303273, 3769.8869033929027, 3920.3335432976464, 3924.2347742190286, 3945.5462621798574, 3946.2502124596235, 5691.613489973501, 5723.399043100498, 5728.942710572925, 5745.299709136699, 5746.54027677789, 4095.28332541804, 4114.930118169297, 4131.731437456556, 4137.627613514738, 4143.482064741907, 4054.0270335119358, 4119.9176016479505, 4131.5042194936195, 4148.979255103765, 4180.519240287406, 4658.930116048262, 4684.203685373494, 4686.835960741358, 4688.320193571913, 4709.434867815884, 5544.669279372922, 5586.35756887955, 5598.412166722435, 5604.851005543936, 5622.85942851432, 1362.6797702539895, 1363.1275983370651, 1386.6533366658336, 1400.4958215042577, 1405.6907480354305, 942.8397172480695, 946.8532377481364, 981.1267971505366, 981.2738573455591, 989.1345073061071, 5221.7128057956415, 5237.3453318335205, 5259.737013149327, 5309.495597918191, 5310.230016647642, 5520.199571062173, 5541.4483944495605, 5545.584081193927, 5562.777488900399, 5605.159226116034, 5070.771815268322, 5236.397814251333, 5243.239730239094, 5280.260763493114, 5317.2024196370085, 2953.586497890297, 3001.159675290922, 3001.6097907271915, 3001.6998300169807, 3002.714742099497, 5854.209681692917, 5862.648241105548, 5869.853253668607, 5881.3530511643685, 5956.540647541294, 5637.577181711306, 5741.540676745851, 5775.740091695884, 5805.622634528742, 5812.273465816773, 5779.682117483495, 5823.446772556685, 5829.795957141479, 5830.679312637845, 5856.941430585724, 5416.7562459688625, 5583.497485226187, 5639.8590035249445, 5683.318001839806, 5706.373683500183, 5584.357798853184, 5591.75678106689, 5610.915836262541, 5613.971930140323, 5615.697563998741, 5838.649681019152, 5912.320083190488, 5913.438223368773, 5914.792982245601, 5917.171595976481, 3929.980350098231, 4082.3264161413035, 4107.137501124797, 4108.4864391951005, 4115.8971025724595, 5348.465153484621, 5557.221988921635, 5609.775608975595, 5641.294838145232, 5644.6330988485615, 5339.946600533945, 5506.201600767947, 5525.806596769255, 5543.556515478833, 5582.385937546947, 5515.227868098389, 5552.305961754781, 5568.691357530896, 5578.30271216098, 5591.916121258266, 5261.210818377274, 5447.863803404946, 5458.4814442627885, 5535.8892822144135, 5547.722613869371, 5531.197976293495, 5533.861653458695, 5536.252605898152, 5545.972270138624, 5557.277553917965, 5416.945830541802, 5439.0, 5445.727713614383, 5497.835064948058, 5520.503154716095], "value": 4222.220717743088, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [801.3068695578323, 805.7623001214641, 826.2563692676587, 826.5371392020469, 840.8066144786703, 15849.603759905995, 15863.524094277162, 16268.34926602936, 16685.91657041716, 16770.32918683251, 15416.3833446662, 15530.84469155308, 15597.454089106883, 15634.921825390857, 15653.295601697922, 771.2133623703819, 783.2246076384396, 785.3599316556988, 786.5909726941986, 786.8662327404355, 651.9967400162992, 767.4167632599209, 784.19228194959, 798.0981490915258, 803.7186984555417, 834.3492076180589, 835.995820020899, 838.375410319313, 839.4585492357426, 840.0, 833.8207285433631, 833.9291160251325, 834.0450184538669, 835.9916400835974, 836.0093289451958, 496.7019788127131, 501.8444282272507, 594.4531031451075, 598.9041753319492, 606.9089636554552, 14413.207273599948, 14442.566722998326, 14443.78334324986, 14448.988570800047, 14467.71064578713, 13954.860451395458, 14543.0, 14593.416263349452, 15005.0, 15203.847961520354, 13141.934290328487, 13261.27063011534, 13475.595732127953, 13492.12301200419, 14011.159330440207, 4425.3140763181755, 4441.75570343631, 4472.485664148599, 4474.82100715971, 4553.840615578472, 85345.57327213325, 85670.57164714199, 85687.0, 86529.56735216346, 87413.56293218557, 10398.376097434179, 10895.492818226845, 11099.667009989713, 11207.0, 11431.31412115259, 18218.45344639663, 18249.087545622664, 18259.360922367654, 18269.45191644253, 18382.0, 8216.589170541569, 8375.664973400995, 8383.8323233535, 8449.66201351939, 8451.619677114544, 4748.216544270226, 4839.903201935942, 4911.8280860169725, 4952.0, 5156.587473002151, 3290.4735242361107, 3442.0706409269355, 3447.3450044491465, 3447.3967055765143, 3447.482877568385, 602.6534742523066, 608.2093278737624, 615.0528186592597, 615.3231445410013, 628.9874202515924, 561.758652574642, 567.1492760858712, 609.1684850179473, 637.4199478474566, 686.5674624986326, 9763.365381250196, 10167.389956602627, 10210.336328138646, 10259.435731034864, 10348.844767328495, 596.4244504053522, 605.794030029792, 633.6134957675814, 642.2838535033404, 681.8806708825936, 4710.175719249118, 5109.412417571953, 5460.262864513319, 5489.835304940858, 5627.746751396197, 120029.39985300192, 124298.0, 124750.0, 125082.0, 125356.37321813333, 103616.48191759143, 104662.4766876176, 106629.0, 110059.0, 111368.0, 94405.0, 95831.52084239674, 96452.51773741227, 98214.0, 99592.50203749079, 10032.448215347935, 10113.747156321151, 10122.645707400501, 10339.741506462098, 10352.482375881327, 49759.751201243766, 51069.489305107956, 51810.22284665658, 52178.478215217365, 52967.47032529779, 71536.64231679017, 78483.0, 78611.60694196721, 79759.60120199595, 81319.0, 13315.467381305027, 13432.597022089352, 13597.320133993459, 13630.659233519242, 14082.22547759842, 13671.17972921628, 13812.171121087089, 14820.555383338517, 15129.848701512845, 15396.615084622974, 14062.718745625234, 14224.0, 14265.42938282457, 14433.134011959317, 14731.26343682833, 13789.931050344683, 14014.649633759238, 14412.279386030446, 14506.854931450973, 15039.540905591557, 13865.306734663429, 13874.89000879907, 14184.432622694976, 14305.856941430453, 14704.926475367554, 11992.40037998114, 12008.39958002114, 12018.819717704417, 12418.316992565495, 12543.874561254635, 11373.260738052, 12312.384380781104, 12393.194442361219, 12539.184952978027, 12784.6803829905], "value": 7717.270583611229, "unit": "score"}], "name": "dromaeo_css", "value": 7300.686475716312, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 118.0, 112.0, 114.0, 122.0, 113.0, 111.0, 111.0, 127.0], "value": 115.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 120.0, 143.0, 183.0, 118.0, 156.0, 145.0, 120.0, 184.0, 119.0], "value": 144.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 161.0, 161.0, 163.0, 161.0, 163.0, 162.0, 163.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 174.0, 77.0, 77.0, 77.0, 76.0, 171.0, 75.0], "value": 95.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 144.0, 82.0, 82.0, 82.0, 150.0, 82.0, 81.0, 148.0], "value": 101.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 116.0, 116.0, 118.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 149.0, 148.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 96.0, 96.0, 95.0, 96.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 50.0, 51.0, 51.0, 53.0, 51.0, 53.0, 52.0, 52.0, 55.0], "value": 52.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 60.0, 62.0, 62.0, 61.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 84.0, 79.0, 79.0, 88.0, 81.0, 78.0, 78.0, 79.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 129.0, 123.0, 125.0, 128.0, 125.0, 124.0, 122.0, 168.0, 128.0], "value": 129.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 167.0, 163.0, 168.0, 163.0, 166.0, 168.0, 165.0, 163.0, 163.0], "value": 164.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 65.0, 64.0, 65.0, 67.0, 65.0, 65.0, 63.0, 70.0], "value": 65.6, "unit": "score"}], "name": "kraken", "value": 1532.2999999999997, "alertThreshold": 2.0}]} 23:53:54 INFO - Return code: 0 23:53:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:53:54 INFO - # TBPL SUCCESS # 23:53:54 INFO - Running post-action listener: _resource_record_post_action 23:53:54 INFO - [mozharness: 2016-09-02 06:53:54.458450Z] Finished run-tests step (success) 23:53:54 INFO - Running post-run listener: _resource_record_post_run 23:53:54 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 418357248; Read time: 12; Write time: 514200 23:53:54 INFO - TinderboxPrint: CPU usage
13.1% 23:53:54 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 23:53:54 INFO - TinderboxPrint: I/O write bytes / time
418,357,248 / 514,200 23:53:54 INFO - TinderboxPrint: CPU idle
8,294.6 (86.9%) 23:53:54 INFO - TinderboxPrint: CPU user
1,197.2 (12.5%) 23:53:54 INFO - TinderboxPrint: Swap in / out
0 / 0 23:53:54 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 128933888; Read time: 0; Write time: 148120 23:53:54 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 288522240; Read time: 0; Write time: 366052 23:53:55 INFO - Running post-run listener: _upload_blobber_files 23:53:55 INFO - Blob upload gear active. 23:53:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:53:55 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 23:53:55 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'] 23:53:55 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 23:53:55 INFO - (blobuploader) - INFO - Open directory for files ... 23:53:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:53:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:53:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:53:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:53:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:53:58 INFO - (blobuploader) - INFO - Done attempting. 23:53:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:53:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:53:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:53:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:53:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:53:59 INFO - (blobuploader) - INFO - Done attempting. 23:53:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:53:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:53:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:54:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:54:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:54:00 INFO - (blobuploader) - INFO - Done attempting. 23:54:00 INFO - (blobuploader) - INFO - Iteration through files over. 23:54:00 INFO - Return code: 0 23:54:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:54:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:54:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6aa22118dc1415e7b3d722e789d465d9604c14d41a93fe1e96fbefd593eb3c3e0b4f3358d49fd5d2cfde438766305ece3159de7bc4254fdaee6cb520b9396628", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9819287e476004e8844012ad5dca6f25743c09c5cfd5334df7728b21adbb2475f74faf867327360b2261698c13726d8a7d6c3d34dd14ea37e757da74766d8db2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/31e3c932ec4d07fa8c351c43717725bcb3a49cb33929f6ddee9f2d3171d7ee3d8954c08c086219964ed2078280cf76328969b66b46564be532e1878372ee0fe5"} 23:54:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:54:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:54:00 INFO - Contents: 23:54:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6aa22118dc1415e7b3d722e789d465d9604c14d41a93fe1e96fbefd593eb3c3e0b4f3358d49fd5d2cfde438766305ece3159de7bc4254fdaee6cb520b9396628", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9819287e476004e8844012ad5dca6f25743c09c5cfd5334df7728b21adbb2475f74faf867327360b2261698c13726d8a7d6c3d34dd14ea37e757da74766d8db2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/31e3c932ec4d07fa8c351c43717725bcb3a49cb33929f6ddee9f2d3171d7ee3d8954c08c086219964ed2078280cf76328969b66b46564be532e1878372ee0fe5"} 23:54:00 INFO - Running post-run listener: copy_logs_to_upload_dir 23:54:00 INFO - Copying logs to upload dir... 23:54:00 INFO - mkdir: /builds/slave/test/build/upload/logs 23:54:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.890039 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-09-01 23:53:58.941042) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 23:53:58.945101) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1472797358.455263-1680859295 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/6aa22118dc1415e7b3d722e789d465d9604c14d41a93fe1e96fbefd593eb3c3e0b4f3358d49fd5d2cfde438766305ece3159de7bc4254fdaee6cb520b9396628", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9819287e476004e8844012ad5dca6f25743c09c5cfd5334df7728b21adbb2475f74faf867327360b2261698c13726d8a7d6c3d34dd14ea37e757da74766d8db2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/31e3c932ec4d07fa8c351c43717725bcb3a49cb33929f6ddee9f2d3171d7ee3d8954c08c086219964ed2078280cf76328969b66b46564be532e1878372ee0fe5"} build_url:https://queue.taskcluster.net/v1/task/W10e_HY_Qua1LTWSUl876A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011135 build_url: 'https://queue.taskcluster.net/v1/task/W10e_HY_Qua1LTWSUl876A/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/6aa22118dc1415e7b3d722e789d465d9604c14d41a93fe1e96fbefd593eb3c3e0b4f3358d49fd5d2cfde438766305ece3159de7bc4254fdaee6cb520b9396628", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9819287e476004e8844012ad5dca6f25743c09c5cfd5334df7728b21adbb2475f74faf867327360b2261698c13726d8a7d6c3d34dd14ea37e757da74766d8db2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/31e3c932ec4d07fa8c351c43717725bcb3a49cb33929f6ddee9f2d3171d7ee3d8954c08c086219964ed2078280cf76328969b66b46564be532e1878372ee0fe5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 23:53:58.974427) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 23:53:58.974783) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1472797358.455263-1680859295 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 23:53:59.059151) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 23:53:59.059863) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 23:53:59.060264) ========= ========= Total master_lag: 0.17 =========