builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-003 starttime: 1471550504.18 results: success (0) buildid: 20160818113003 builduid: 71118355ef194af19a1a20ed98ef8df5 revision: dce857dd57e2d91ae4c6014cf21e93ef95e4dd36 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-18 13:01:44.182031) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-18 13:01:44.182462) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-18 13:01:44.182738) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-18 13:01:44.197561) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 13:01:44.197885) ========= 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=7de08804244eb36560b44971000001c3-1471550502.828633-1541337525 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-18 13:01:44-- 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% 7.10M=0.002s 2016-08-18 13:01:44 (7.10 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.473581 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 13:01:44.687904) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 13:01:44.688236) ========= 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=7de08804244eb36560b44971000001c3-1471550502.828633-1541337525 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016808 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 13:01:44.741641) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 13:01:44.741978) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev dce857dd57e2d91ae4c6014cf21e93ef95e4dd36 --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 dce857dd57e2d91ae4c6014cf21e93ef95e4dd36 --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=7de08804244eb36560b44971000001c3-1471550502.828633-1541337525 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-18 13:01:44,902 truncating revision to first 12 chars 2016-08-18 13:01:44,902 Setting DEBUG logging. 2016-08-18 13:01:44,902 attempt 1/10 2016-08-18 13:01:44,902 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/dce857dd57e2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-18 13:01:45,245 unpacking tar archive at: fx-team-dce857dd57e2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.916657 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 13:01:45.672457) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-18 13:01:45.672775) ========= script_repo_revision: dce857dd57e2d91ae4c6014cf21e93ef95e4dd36 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-18 13:01:45.681259) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-18 13:01:45.681615) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-18 13:01:45.692768) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-08-18 13:01:45.693137) ========= /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=7de08804244eb36560b44971000001c3-1471550502.828633-1541337525 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:01:45 INFO - MultiFileLogger online at 20160818 13:01:45 in /builds/slave/test 13:01:45 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 13:01:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:01:45 INFO - {'append_to_log': False, 13:01:45 INFO - 'base_work_dir': '/builds/slave/test', 13:01:45 INFO - 'blob_upload_branch': 'Fx-Team', 13:01:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:01:45 INFO - 'branch': 'Fx-Team', 13:01:45 INFO - 'buildbot_json_path': 'buildprops.json', 13:01:45 INFO - 'config_files': ('talos/linux_config.py',), 13:01:45 INFO - 'default_actions': ('clobber', 13:01:45 INFO - 'read-buildbot-config', 13:01:45 INFO - 'download-and-extract', 13:01:45 INFO - 'populate-webroot', 13:01:45 INFO - 'create-virtualenv', 13:01:45 INFO - 'install', 13:01:45 INFO - 'run-tests'), 13:01:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:01:45 INFO - 'download_minidump_stackwalk': True, 13:01:45 INFO - 'download_symbols': 'ondemand', 13:01:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:01:45 INFO - 'tooltool.py': '/tools/tooltool.py', 13:01:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:01:45 INFO - '/tools/misc-python/virtualenv.py')}, 13:01:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:01:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:01:45 INFO - 'installer_path': 'installer.exe', 13:01:45 INFO - 'log_level': 'info', 13:01:45 INFO - 'log_name': 'talos', 13:01:45 INFO - 'log_to_console': True, 13:01:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:01:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:01:45 INFO - 'opt_config_files': (), 13:01:45 INFO - 'pip_index': False, 13:01:45 INFO - 'sps_profile': False, 13:01:45 INFO - 'sps_profile_interval': 0, 13:01:45 INFO - 'suite': 'dromaeojs', 13:01:45 INFO - 'system_bits': '32', 13:01:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:01:45 INFO - 'title': 'talos-linux64-ix-003', 13:01:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:01:45 INFO - 'use_talos_json': True, 13:01:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:01:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:01:45 INFO - 'work_dir': 'build'} 13:01:45 INFO - [mozharness: 2016-08-18 20:01:45.957354Z] Running clobber step. 13:01:45 INFO - Running pre-action listener: _resource_record_pre_action 13:01:45 INFO - Running main action method: clobber 13:01:45 INFO - rmtree: /builds/slave/test/build 13:01:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:01:46 INFO - Running post-action listener: _resource_record_post_action 13:01:46 INFO - [mozharness: 2016-08-18 20:01:46.416283Z] Finished clobber step (success) 13:01:46 INFO - [mozharness: 2016-08-18 20:01:46.416382Z] Running read-buildbot-config step. 13:01:46 INFO - Running pre-action listener: _resource_record_pre_action 13:01:46 INFO - Running main action method: read_buildbot_config 13:01:46 INFO - Using buildbot properties: 13:01:46 INFO - { 13:01:46 INFO - "project": "", 13:01:46 INFO - "product": "firefox", 13:01:46 INFO - "script_repo_revision": "production", 13:01:46 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:01:46 INFO - "repository": "", 13:01:46 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 13:01:46 INFO - "buildid": "20160818113003", 13:01:46 INFO - "pgo_build": "True", 13:01:46 INFO - "basedir": "/builds/slave/test", 13:01:46 INFO - "buildnumber": 371, 13:01:46 INFO - "slavename": "talos-linux64-ix-003", 13:01:46 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:01:46 INFO - "platform": "ubuntu64_hw", 13:01:46 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 13:01:46 INFO - "branch": "fx-team", 13:01:46 INFO - "repo_path": "integration/fx-team", 13:01:46 INFO - "revision": "dce857dd57e2d91ae4c6014cf21e93ef95e4dd36", 13:01:46 INFO - "stage_platform": "linux64-pgo", 13:01:46 INFO - "builduid": "71118355ef194af19a1a20ed98ef8df5", 13:01:46 INFO - "slavebuilddir": "test" 13:01:46 INFO - } 13:01:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZjA3gEcrR_-l_pMB417TSg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 13:01:46 INFO - Running post-action listener: _resource_record_post_action 13:01:46 INFO - [mozharness: 2016-08-18 20:01:46.418805Z] Finished read-buildbot-config step (success) 13:01:46 INFO - [mozharness: 2016-08-18 20:01:46.418894Z] Running download-and-extract step. 13:01:46 INFO - Running pre-action listener: _resource_record_pre_action 13:01:46 INFO - Running main action method: download_and_extract 13:01:46 INFO - mkdir: /builds/slave/test/build/tests 13:01: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')]} 13:01:46 INFO - trying https://queue.taskcluster.net/v1/task/ZjA3gEcrR_-l_pMB417TSg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 13:01:46 INFO - Downloading https://queue.taskcluster.net/v1/task/ZjA3gEcrR_-l_pMB417TSg/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 13:01:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZjA3gEcrR_-l_pMB417TSg/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 13:01:46 INFO - Downloaded 1361 bytes. 13:01:46 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 13:01:46 INFO - Using the following test package requirements: 13:01:46 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 13:01:46 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:01:46 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:01:46 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:01:46 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:01:46 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:01:46 INFO - u'jsshell-linux-x86_64.zip'], 13:01:46 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:01:46 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:01:46 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 13:01:46 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:01:46 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:01:46 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:01:46 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:01:46 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:01:46 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:01:46 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:01:46 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:01:46 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:01: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')]} 13:01:46 INFO - trying https://queue.taskcluster.net/v1/task/ZjA3gEcrR_-l_pMB417TSg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 13:01:46 INFO - Downloading https://queue.taskcluster.net/v1/task/ZjA3gEcrR_-l_pMB417TSg/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 13:01:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZjA3gEcrR_-l_pMB417TSg/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 13:01:47 INFO - Downloaded 21905770 bytes. 13:01:47 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 13:01:52 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 13:01:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:01:52 INFO - trying https://queue.taskcluster.net/v1/task/ZjA3gEcrR_-l_pMB417TSg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 13:01:52 INFO - Downloading https://queue.taskcluster.net/v1/task/ZjA3gEcrR_-l_pMB417TSg/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 13:01:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZjA3gEcrR_-l_pMB417TSg/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 13:01:52 INFO - Downloaded 21905770 bytes. 13:01:52 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 13:01:58 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')]} 13:01:58 INFO - trying https://queue.taskcluster.net/v1/task/ZjA3gEcrR_-l_pMB417TSg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 13:01:58 INFO - Downloading https://queue.taskcluster.net/v1/task/ZjA3gEcrR_-l_pMB417TSg/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 13:01:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZjA3gEcrR_-l_pMB417TSg/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 13:01:59 INFO - Downloaded 14413981 bytes. 13:01:59 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 13:01:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:01:59 INFO - trying https://queue.taskcluster.net/v1/task/ZjA3gEcrR_-l_pMB417TSg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 13:01:59 INFO - Downloading https://queue.taskcluster.net/v1/task/ZjA3gEcrR_-l_pMB417TSg/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 13:01:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZjA3gEcrR_-l_pMB417TSg/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 13:02:00 INFO - Downloaded 59591696 bytes. 13:02:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZjA3gEcrR_-l_pMB417TSg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 13:02:00 INFO - mkdir: /builds/slave/test/properties 13:02:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:02:00 INFO - Writing to file /builds/slave/test/properties/build_url 13:02:00 INFO - Contents: 13:02:00 INFO - build_url:https://queue.taskcluster.net/v1/task/ZjA3gEcrR_-l_pMB417TSg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 13:02:01 INFO - Running post-action listener: _resource_record_post_action 13:02:01 INFO - Running post-action listener: set_extra_try_arguments 13:02:01 INFO - [mozharness: 2016-08-18 20:02:01.225975Z] Finished download-and-extract step (success) 13:02:01 INFO - [mozharness: 2016-08-18 20:02:01.226200Z] Running populate-webroot step. 13:02:01 INFO - Running pre-action listener: _resource_record_pre_action 13:02:01 INFO - Running main action method: populate_webroot 13:02:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:02:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:02:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:02:01 INFO - '--tppagecycles', 13:02:01 INFO - '7'], 13:02:01 INFO - 'tests': ['tsvgm']}}, 13:02:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:02:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:02:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:02:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:02:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:02:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:02:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:01 INFO - 'talos_options': ['--disable-e10s'], 13:02:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:02:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:02:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:01 INFO - 'talos_options': ['--disable-e10s'], 13:02:01 INFO - 'tests': ['damp', 'tps']}, 13:02:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:01 INFO - 'tests': ['damp', 'tps']}, 13:02:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:02:01 INFO - 'tests': ['dromaeo_dom']}, 13:02:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:02:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:02:01 INFO - 'tests': ['basic_compositor_video']}, 13:02:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:02:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:02:01 INFO - 'tests': ['a11yr', 13:02:01 INFO - 'ts_paint', 13:02:01 INFO - 'tpaint', 13:02:01 INFO - 'sessionrestore', 13:02:01 INFO - 'sessionrestore_no_auto_restore', 13:02:01 INFO - 'tabpaint']}, 13:02:01 INFO - 'other-e10s': {'tests': ['a11yr', 13:02:01 INFO - 'ts_paint', 13:02:01 INFO - 'tpaint', 13:02:01 INFO - 'sessionrestore', 13:02:01 INFO - 'sessionrestore_no_auto_restore', 13:02:01 INFO - 'tabpaint']}, 13:02:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:02:01 INFO - 'ts_paint', 13:02:01 INFO - 'tpaint', 13:02:01 INFO - 'sessionrestore', 13:02:01 INFO - 'sessionrestore_no_auto_restore', 13:02:01 INFO - 'tabpaint']}, 13:02:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:02:01 INFO - 'ts_paint', 13:02:01 INFO - 'tpaint', 13:02:01 INFO - 'sessionrestore', 13:02:01 INFO - 'sessionrestore_no_auto_restore', 13:02:01 INFO - 'tabpaint']}, 13:02:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:02:01 INFO - 'tests': ['a11yr', 13:02:01 INFO - 'ts_paint', 13:02:01 INFO - 'tpaint', 13:02:01 INFO - 'sessionrestore', 13:02:01 INFO - 'sessionrestore_no_auto_restore', 13:02:01 INFO - 'tabpaint']}, 13:02:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:02:01 INFO - 'tests': ['a11yr', 13:02:01 INFO - 'ts_paint', 13:02:01 INFO - 'tpaint', 13:02:01 INFO - 'sessionrestore', 13:02:01 INFO - 'sessionrestore_no_auto_restore', 13:02:01 INFO - 'tabpaint']}, 13:02:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:02:01 INFO - 'tests': ['tsvgx', 13:02:01 INFO - 'tsvgr_opacity', 13:02:01 INFO - 'tart', 13:02:01 INFO - 'tscrollx', 13:02:01 INFO - 'cart']}, 13:02:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:02:01 INFO - 'tsvgr_opacity', 13:02:01 INFO - 'tart', 13:02:01 INFO - 'tscrollx', 13:02:01 INFO - 'cart']}, 13:02:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:01 INFO - 'talos_options': ['--disable-e10s'], 13:02:01 INFO - 'tests': ['tp5o']}, 13:02:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:01 INFO - 'tests': ['tp5o']}, 13:02:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:01 INFO - 'talos_options': ['--disable-e10s', 13:02:01 INFO - '--xperf_path', 13:02:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:02:01 INFO - 'tests': ['tp5n']}, 13:02:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:01 INFO - 'talos_options': ['--xperf_path', 13:02:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:02:01 INFO - 'tests': ['tp5n']}}, 13:02:01 INFO - 'talos.zip': {'path': '', 13:02:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:02:01 INFO - Running post-action listener: _resource_record_post_action 13:02:01 INFO - [mozharness: 2016-08-18 20:02:01.243886Z] Finished populate-webroot step (success) 13:02:01 INFO - [mozharness: 2016-08-18 20:02:01.243975Z] Running create-virtualenv step. 13:02:01 INFO - Running pre-action listener: _resource_record_pre_action 13:02:01 INFO - Running main action method: create_virtualenv 13:02:01 INFO - Creating virtualenv /builds/slave/test/build/venv 13:02:01 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 13:02:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:02:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:02:01 INFO - Using real prefix '/usr' 13:02:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:02:01 INFO - Installing distribute.............................................................................................................................................................................................done. 13:02:03 INFO - Installing pip.................done. 13:02:03 INFO - Return code: 0 13:02:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:02:03 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')]} 13:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:03 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')]} 13:02:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:03 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 0x7f9fdcb13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1481850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147c370>, '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 0x147f8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147fd80>, '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': '7de08804244eb36560b44971000001c3-1471550502.828633-1541337525', '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 13:02:03 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 13:02:03 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 13:02:03 INFO - Using env: {'DISPLAY': ':0', 13:02:03 INFO - 'HOME': '/home/cltbld', 13:02:03 INFO - 'LANG': 'en_US.UTF-8', 13:02:03 INFO - 'LANGUAGE': 'en_US:en', 13:02:03 INFO - 'LOGNAME': 'cltbld', 13:02:03 INFO - 'MAIL': '/var/mail/cltbld', 13:02:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:03 INFO - 'MOZ_NO_REMOTE': '1', 13:02:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:03 INFO - 'NO_EM_RESTART': '1', 13:02:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:02:03 INFO - 'PWD': '/builds/slave/test', 13:02:03 INFO - 'SHELL': '/bin/bash', 13:02:03 INFO - 'SHLVL': '1', 13:02:03 INFO - 'TERM': 'linux', 13:02:03 INFO - 'TMOUT': '86400', 13:02:03 INFO - 'USER': 'cltbld', 13:02:03 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1471550502.828633-1541337525', 13:02:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:03 INFO - '_': '/tools/buildbot/bin/python'} 13:02:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:04 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 13:02:04 INFO - Cleaning up... 13:02:04 INFO - Return code: 0 13:02:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:02:04 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')]} 13:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:04 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')]} 13:02:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:04 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 0x7f9fdcb13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1481850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147c370>, '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 0x147f8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147fd80>, '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': '7de08804244eb36560b44971000001c3-1471550502.828633-1541337525', '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 13:02:04 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 13:02:04 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 13:02:04 INFO - Using env: {'DISPLAY': ':0', 13:02:04 INFO - 'HOME': '/home/cltbld', 13:02:04 INFO - 'LANG': 'en_US.UTF-8', 13:02:04 INFO - 'LANGUAGE': 'en_US:en', 13:02:04 INFO - 'LOGNAME': 'cltbld', 13:02:04 INFO - 'MAIL': '/var/mail/cltbld', 13:02:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:04 INFO - 'MOZ_NO_REMOTE': '1', 13:02:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:04 INFO - 'NO_EM_RESTART': '1', 13:02:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:02:04 INFO - 'PWD': '/builds/slave/test', 13:02:04 INFO - 'SHELL': '/bin/bash', 13:02:04 INFO - 'SHLVL': '1', 13:02:04 INFO - 'TERM': 'linux', 13:02:04 INFO - 'TMOUT': '86400', 13:02:04 INFO - 'USER': 'cltbld', 13:02:04 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1471550502.828633-1541337525', 13:02:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:04 INFO - '_': '/tools/buildbot/bin/python'} 13:02:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:04 INFO - Downloading/unpacking psutil>=3.1.1 13:02:04 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 13:02:04 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 13:02:04 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 13:02:04 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 13:02:04 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 13:02:04 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 13:02:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:02:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:02:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:02:06 INFO - Installing collected packages: psutil 13:02:06 INFO - Running setup.py install for psutil 13:02:06 INFO - building 'psutil._psutil_linux' extension 13:02:06 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 13:02:06 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 13:02:06 INFO - building 'psutil._psutil_posix' extension 13:02:06 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 13:02:06 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 13:02:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:02:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:02:06 INFO - Successfully installed psutil 13:02:06 INFO - Cleaning up... 13:02:06 INFO - Return code: 0 13:02:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:02:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:02:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:06 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 0x7f9fdcb13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1481850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147c370>, '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 0x147f8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147fd80>, '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': '7de08804244eb36560b44971000001c3-1471550502.828633-1541337525', '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 13:02:06 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 13:02:06 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 13:02:06 INFO - Using env: {'DISPLAY': ':0', 13:02:06 INFO - 'HOME': '/home/cltbld', 13:02:06 INFO - 'LANG': 'en_US.UTF-8', 13:02:06 INFO - 'LANGUAGE': 'en_US:en', 13:02:06 INFO - 'LOGNAME': 'cltbld', 13:02:06 INFO - 'MAIL': '/var/mail/cltbld', 13:02:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:06 INFO - 'MOZ_NO_REMOTE': '1', 13:02:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:06 INFO - 'NO_EM_RESTART': '1', 13:02:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:02:06 INFO - 'PWD': '/builds/slave/test', 13:02:06 INFO - 'SHELL': '/bin/bash', 13:02:06 INFO - 'SHLVL': '1', 13:02:06 INFO - 'TERM': 'linux', 13:02:06 INFO - 'TMOUT': '86400', 13:02:06 INFO - 'USER': 'cltbld', 13:02:06 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1471550502.828633-1541337525', 13:02:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:06 INFO - '_': '/tools/buildbot/bin/python'} 13:02:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:02:07 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 13:02:07 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 13:02:07 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 13:02:07 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 13:02:07 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 13:02:07 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 13:02:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:02:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:02:08 INFO - Installing collected packages: mozsystemmonitor 13:02:08 INFO - Running setup.py install for mozsystemmonitor 13:02:09 INFO - Successfully installed mozsystemmonitor 13:02:09 INFO - Cleaning up... 13:02:09 INFO - Return code: 0 13:02:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:02:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:02:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:09 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 0x7f9fdcb13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1481850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147c370>, '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 0x147f8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147fd80>, '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': '7de08804244eb36560b44971000001c3-1471550502.828633-1541337525', '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 13:02:09 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 13:02:09 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 13:02:09 INFO - Using env: {'DISPLAY': ':0', 13:02:09 INFO - 'HOME': '/home/cltbld', 13:02:09 INFO - 'LANG': 'en_US.UTF-8', 13:02:09 INFO - 'LANGUAGE': 'en_US:en', 13:02:09 INFO - 'LOGNAME': 'cltbld', 13:02:09 INFO - 'MAIL': '/var/mail/cltbld', 13:02:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:09 INFO - 'MOZ_NO_REMOTE': '1', 13:02:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:09 INFO - 'NO_EM_RESTART': '1', 13:02:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:02:09 INFO - 'PWD': '/builds/slave/test', 13:02:09 INFO - 'SHELL': '/bin/bash', 13:02:09 INFO - 'SHLVL': '1', 13:02:09 INFO - 'TERM': 'linux', 13:02:09 INFO - 'TMOUT': '86400', 13:02:09 INFO - 'USER': 'cltbld', 13:02:09 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1471550502.828633-1541337525', 13:02:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:09 INFO - '_': '/tools/buildbot/bin/python'} 13:02:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:09 INFO - Downloading/unpacking jsonschema==2.5.1 13:02:09 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 13:02:09 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 13:02:09 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 13:02:09 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 13:02:09 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 13:02:09 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 13:02:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:02:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:02:11 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 13:02:11 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 13:02:11 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 13:02:11 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 13:02:11 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 13:02:11 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 13:02:11 INFO - Downloading functools32-3.2.3-2.tar.gz 13:02:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:02:11 INFO - warning: no files found matching '*.txt' 13:02:11 INFO - no previously-included directories found matching 'build' 13:02:11 INFO - no previously-included directories found matching 'dist' 13:02:11 INFO - no previously-included directories found matching '.git*' 13:02:11 INFO - Installing collected packages: jsonschema, functools32 13:02:11 INFO - Running setup.py install for functools32 13:02:11 INFO - warning: no files found matching '*.txt' 13:02:11 INFO - no previously-included directories found matching 'build' 13:02:11 INFO - no previously-included directories found matching 'dist' 13:02:11 INFO - no previously-included directories found matching '.git*' 13:02:11 INFO - Successfully installed jsonschema functools32 13:02:11 INFO - Cleaning up... 13:02:11 INFO - Return code: 0 13:02:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:02:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9fdcb13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1481850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147c370>, '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 0x147f8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147fd80>, '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': '7de08804244eb36560b44971000001c3-1471550502.828633-1541337525', '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 13:02:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:02:11 INFO - Using env: {'DISPLAY': ':0', 13:02:11 INFO - 'HOME': '/home/cltbld', 13:02:11 INFO - 'LANG': 'en_US.UTF-8', 13:02:11 INFO - 'LANGUAGE': 'en_US:en', 13:02:11 INFO - 'LOGNAME': 'cltbld', 13:02:11 INFO - 'MAIL': '/var/mail/cltbld', 13:02:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:11 INFO - 'MOZ_NO_REMOTE': '1', 13:02:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:11 INFO - 'NO_EM_RESTART': '1', 13:02:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:02:11 INFO - 'PWD': '/builds/slave/test', 13:02:11 INFO - 'SHELL': '/bin/bash', 13:02:11 INFO - 'SHLVL': '1', 13:02:11 INFO - 'TERM': 'linux', 13:02:11 INFO - 'TMOUT': '86400', 13:02:11 INFO - 'USER': 'cltbld', 13:02:11 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1471550502.828633-1541337525', 13:02:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:11 INFO - '_': '/tools/buildbot/bin/python'} 13:02:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:02:11 INFO - Cleaning up... 13:02:11 INFO - Return code: 0 13:02:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:02:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9fdcb13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1481850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147c370>, '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 0x147f8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147fd80>, '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': '7de08804244eb36560b44971000001c3-1471550502.828633-1541337525', '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 13:02:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:02:11 INFO - Using env: {'DISPLAY': ':0', 13:02:11 INFO - 'HOME': '/home/cltbld', 13:02:11 INFO - 'LANG': 'en_US.UTF-8', 13:02:11 INFO - 'LANGUAGE': 'en_US:en', 13:02:11 INFO - 'LOGNAME': 'cltbld', 13:02:11 INFO - 'MAIL': '/var/mail/cltbld', 13:02:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:11 INFO - 'MOZ_NO_REMOTE': '1', 13:02:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:11 INFO - 'NO_EM_RESTART': '1', 13:02:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:02:11 INFO - 'PWD': '/builds/slave/test', 13:02:11 INFO - 'SHELL': '/bin/bash', 13:02:11 INFO - 'SHLVL': '1', 13:02:11 INFO - 'TERM': 'linux', 13:02:11 INFO - 'TMOUT': '86400', 13:02:11 INFO - 'USER': 'cltbld', 13:02:11 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1471550502.828633-1541337525', 13:02:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:11 INFO - '_': '/tools/buildbot/bin/python'} 13:02:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:12 INFO - Downloading/unpacking blobuploader==1.2.4 13:02:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:02:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:02:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:02:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:02:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:02:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:02:13 INFO - Downloading blobuploader-1.2.4.tar.gz 13:02:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:02:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:02:14 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 13:02:14 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 13:02:14 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 13:02:14 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 13:02:14 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 13:02:14 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 13:02:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:02:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:02:14 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 13:02:14 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 13:02:14 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 13:02:14 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 13:02:14 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 13:02:14 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 13:02:14 INFO - Downloading docopt-0.6.1.tar.gz 13:02:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:02:14 INFO - Installing collected packages: blobuploader, requests, docopt 13:02:14 INFO - Running setup.py install for blobuploader 13:02:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:02:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:02:14 INFO - Running setup.py install for requests 13:02:15 INFO - Running setup.py install for docopt 13:02:15 INFO - Successfully installed blobuploader requests docopt 13:02:15 INFO - Cleaning up... 13:02:15 INFO - Return code: 0 13:02:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:02: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')]} 13:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02: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')]} 13:02:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:15 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 0x7f9fdcb13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1481850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147c370>, '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 0x147f8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147fd80>, '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': '7de08804244eb36560b44971000001c3-1471550502.828633-1541337525', '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 13:02:15 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 13:02:15 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 13:02:15 INFO - Using env: {'DISPLAY': ':0', 13:02:15 INFO - 'HOME': '/home/cltbld', 13:02:15 INFO - 'LANG': 'en_US.UTF-8', 13:02:15 INFO - 'LANGUAGE': 'en_US:en', 13:02:15 INFO - 'LOGNAME': 'cltbld', 13:02:15 INFO - 'MAIL': '/var/mail/cltbld', 13:02:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:15 INFO - 'MOZ_NO_REMOTE': '1', 13:02:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:15 INFO - 'NO_EM_RESTART': '1', 13:02:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:02:15 INFO - 'PWD': '/builds/slave/test', 13:02:15 INFO - 'SHELL': '/bin/bash', 13:02:15 INFO - 'SHLVL': '1', 13:02:15 INFO - 'TERM': 'linux', 13:02:15 INFO - 'TMOUT': '86400', 13:02:15 INFO - 'USER': 'cltbld', 13:02:15 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1471550502.828633-1541337525', 13:02:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:15 INFO - '_': '/tools/buildbot/bin/python'} 13:02:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:02:15 INFO - Running setup.py (path:/tmp/pip-ZRmEjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:02:15 INFO - Running setup.py (path:/tmp/pip-iOiM1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:02:15 INFO - Running setup.py (path:/tmp/pip-iDm8Tg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:02:15 INFO - Running setup.py (path:/tmp/pip-M35Nyr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:02:15 INFO - Running setup.py (path:/tmp/pip-7QODkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:02:15 INFO - Running setup.py (path:/tmp/pip-bfQxkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:02:15 INFO - Running setup.py (path:/tmp/pip-i0CVrX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:02:16 INFO - Running setup.py (path:/tmp/pip-7cIoy6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:02:16 INFO - Running setup.py (path:/tmp/pip-b9nfSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:02:16 INFO - Running setup.py (path:/tmp/pip-9SkpxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:02:16 INFO - Running setup.py (path:/tmp/pip-bh5kh_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:02:16 INFO - Running setup.py (path:/tmp/pip-uiGQrb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:02:16 INFO - Running setup.py (path:/tmp/pip-GSTRz6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:02:16 INFO - Running setup.py (path:/tmp/pip-ijWQ1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:02:16 INFO - Running setup.py (path:/tmp/pip-zktALB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:02:16 INFO - Running setup.py (path:/tmp/pip-9CJpbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:02:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:02:16 INFO - Running setup.py (path:/tmp/pip-Um34g_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:02:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:02:16 INFO - Running setup.py install for manifestparser 13:02:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:02:16 INFO - Running setup.py install for mozcrash 13:02:16 INFO - Running setup.py install for mozdebug 13:02:17 INFO - Running setup.py install for mozdevice 13:02:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:02:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:02:17 INFO - Running setup.py install for mozfile 13:02:17 INFO - Running setup.py install for mozhttpd 13:02:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:02:17 INFO - Running setup.py install for mozinfo 13:02:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:02:17 INFO - Running setup.py install for mozInstall 13:02:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:02:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:02:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:02:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:02:17 INFO - Running setup.py install for mozleak 13:02:17 INFO - Running setup.py install for mozlog 13:02:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:02:17 INFO - Running setup.py install for moznetwork 13:02:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:02:17 INFO - Running setup.py install for mozprocess 13:02:18 INFO - Running setup.py install for mozprofile 13:02:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:02:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:02:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:02:18 INFO - Running setup.py install for mozrunner 13:02:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:02:18 INFO - Running setup.py install for mozscreenshot 13:02:18 INFO - Running setup.py install for moztest 13:02:18 INFO - Running setup.py install for mozversion 13:02:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:02:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:02:18 INFO - Cleaning up... 13:02:18 INFO - Return code: 0 13:02:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:02:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:02:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:02:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:18 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 0x7f9fdcb13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1481850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147c370>, '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 0x147f8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147fd80>, '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': '7de08804244eb36560b44971000001c3-1471550502.828633-1541337525', '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 13:02:18 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 13:02:18 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 13:02:18 INFO - Using env: {'DISPLAY': ':0', 13:02:18 INFO - 'HOME': '/home/cltbld', 13:02:18 INFO - 'LANG': 'en_US.UTF-8', 13:02:18 INFO - 'LANGUAGE': 'en_US:en', 13:02:18 INFO - 'LOGNAME': 'cltbld', 13:02:18 INFO - 'MAIL': '/var/mail/cltbld', 13:02:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:18 INFO - 'MOZ_NO_REMOTE': '1', 13:02:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:18 INFO - 'NO_EM_RESTART': '1', 13:02:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:02:18 INFO - 'PWD': '/builds/slave/test', 13:02:18 INFO - 'SHELL': '/bin/bash', 13:02:18 INFO - 'SHLVL': '1', 13:02:18 INFO - 'TERM': 'linux', 13:02:18 INFO - 'TMOUT': '86400', 13:02:18 INFO - 'USER': 'cltbld', 13:02:18 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1471550502.828633-1541337525', 13:02:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:18 INFO - '_': '/tools/buildbot/bin/python'} 13:02:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:02:18 INFO - Running setup.py (path:/tmp/pip-TAF5CK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:02:18 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)) 13:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:02:18 INFO - Running setup.py (path:/tmp/pip-a3SF5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:02:18 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)) 13:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:02:18 INFO - Running setup.py (path:/tmp/pip-ey7q6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:02:18 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)) 13:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:02:19 INFO - Running setup.py (path:/tmp/pip-KJ9hRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:02:19 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)) 13:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:02:19 INFO - Running setup.py (path:/tmp/pip-bNZSAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:02:19 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)) 13:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:02:19 INFO - Running setup.py (path:/tmp/pip-tGGW1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:02:19 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)) 13:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:02:19 INFO - Running setup.py (path:/tmp/pip-wRiOtw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:02:19 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)) 13:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:02:19 INFO - Running setup.py (path:/tmp/pip-uc64dQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:02:19 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)) 13:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:02:19 INFO - Running setup.py (path:/tmp/pip-Cmg4kR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:02:19 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)) 13:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:02:19 INFO - Running setup.py (path:/tmp/pip-xM9TSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:02:19 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)) 13:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:02:19 INFO - Running setup.py (path:/tmp/pip-Gt5QB7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:02:19 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)) 13:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:02:19 INFO - Running setup.py (path:/tmp/pip-gqTV3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:02:19 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)) 13:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:02:19 INFO - Running setup.py (path:/tmp/pip-oMlc3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:02:19 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)) 13:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:02:19 INFO - Running setup.py (path:/tmp/pip-hCG9fr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:02:19 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)) 13:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:02:19 INFO - Running setup.py (path:/tmp/pip-O1yCqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:02:19 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)) 13:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:02:19 INFO - Running setup.py (path:/tmp/pip-PADlpS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:02:19 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)) 13:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:02:19 INFO - Running setup.py (path:/tmp/pip-fgC4cJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:02:20 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)) 13:02:20 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)) 13:02:20 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)) 13:02:20 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)) 13:02:20 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)) 13:02:20 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)) 13:02:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:02:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:02:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:02:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:02:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:02:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:02:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:02:21 INFO - Downloading blessings-1.6.tar.gz 13:02:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:02:21 INFO - Installing collected packages: blessings 13:02:21 INFO - Running setup.py install for blessings 13:02:22 INFO - Successfully installed blessings 13:02:22 INFO - Cleaning up... 13:02:22 INFO - Return code: 0 13:02:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:02:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:02:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:02:22 INFO - Reading from file tmpfile_stdout 13:02:22 INFO - Current package versions: 13:02:22 INFO - argparse == 1.2.1 13:02:22 INFO - blessings == 1.6 13:02:22 INFO - blobuploader == 1.2.4 13:02:22 INFO - docopt == 0.6.1 13:02:22 INFO - functools32 == 3.2.3-2 13:02:22 INFO - jsonschema == 2.5.1 13:02:22 INFO - manifestparser == 1.1 13:02:22 INFO - mozInstall == 1.12 13:02:22 INFO - mozcrash == 0.17 13:02:22 INFO - mozdebug == 0.1 13:02:22 INFO - mozdevice == 0.48 13:02:22 INFO - mozfile == 1.2 13:02:22 INFO - mozhttpd == 0.7 13:02:22 INFO - mozinfo == 0.9 13:02:22 INFO - mozleak == 0.1 13:02:22 INFO - mozlog == 3.3 13:02:22 INFO - moznetwork == 0.27 13:02:22 INFO - mozprocess == 0.23 13:02:22 INFO - mozprofile == 0.28 13:02:22 INFO - mozrunner == 6.12 13:02:22 INFO - mozscreenshot == 0.1 13:02:22 INFO - mozsystemmonitor == 0.3 13:02:22 INFO - moztest == 0.7 13:02:22 INFO - mozversion == 1.4 13:02:22 INFO - psutil == 3.1.1 13:02:22 INFO - requests == 1.2.3 13:02:22 INFO - wsgiref == 0.1.2 13:02:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:02: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')]} 13:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02: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')]} 13:02:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:22 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 0x7f9fdcb13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1481850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147c370>, '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 0x147f8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147fd80>, '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': '7de08804244eb36560b44971000001c3-1471550502.828633-1541337525', '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 13:02:22 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 13:02:22 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 13:02:22 INFO - Using env: {'DISPLAY': ':0', 13:02:22 INFO - 'HOME': '/home/cltbld', 13:02:22 INFO - 'LANG': 'en_US.UTF-8', 13:02:22 INFO - 'LANGUAGE': 'en_US:en', 13:02:22 INFO - 'LOGNAME': 'cltbld', 13:02:22 INFO - 'MAIL': '/var/mail/cltbld', 13:02:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:22 INFO - 'MOZ_NO_REMOTE': '1', 13:02:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:22 INFO - 'NO_EM_RESTART': '1', 13:02:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:02:22 INFO - 'PWD': '/builds/slave/test', 13:02:22 INFO - 'SHELL': '/bin/bash', 13:02:22 INFO - 'SHLVL': '1', 13:02:22 INFO - 'TERM': 'linux', 13:02:22 INFO - 'TMOUT': '86400', 13:02:22 INFO - 'USER': 'cltbld', 13:02:22 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1471550502.828633-1541337525', 13:02:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:22 INFO - '_': '/tools/buildbot/bin/python'} 13:02:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:22 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)) 13:02:22 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)) 13:02:22 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)) 13:02:22 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)) 13:02:22 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)) 13:02:22 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)) 13:02:22 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)) 13:02:22 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)) 13:02:22 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)) 13:02:22 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)) 13:02:22 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)) 13:02:22 INFO - Cleaning up... 13:02:22 INFO - Return code: 0 13:02:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:02: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')]} 13:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02: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')]} 13:02:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:22 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 0x7f9fdcb13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1481850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147c370>, '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 0x147f8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147fd80>, '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': '7de08804244eb36560b44971000001c3-1471550502.828633-1541337525', '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 13:02:22 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 13:02:22 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 13:02:22 INFO - Using env: {'DISPLAY': ':0', 13:02:22 INFO - 'HOME': '/home/cltbld', 13:02:22 INFO - 'LANG': 'en_US.UTF-8', 13:02:22 INFO - 'LANGUAGE': 'en_US:en', 13:02:22 INFO - 'LOGNAME': 'cltbld', 13:02:22 INFO - 'MAIL': '/var/mail/cltbld', 13:02:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:22 INFO - 'MOZ_NO_REMOTE': '1', 13:02:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:22 INFO - 'NO_EM_RESTART': '1', 13:02:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:02:22 INFO - 'PWD': '/builds/slave/test', 13:02:22 INFO - 'SHELL': '/bin/bash', 13:02:22 INFO - 'SHLVL': '1', 13:02:22 INFO - 'TERM': 'linux', 13:02:22 INFO - 'TMOUT': '86400', 13:02:22 INFO - 'USER': 'cltbld', 13:02:22 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1471550502.828633-1541337525', 13:02:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:22 INFO - '_': '/tools/buildbot/bin/python'} 13:02:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:02:22 INFO - Cleaning up... 13:02:22 INFO - Return code: 0 13:02:22 INFO - Running post-action listener: _resource_record_post_action 13:02:22 INFO - Running post-action listener: _start_resource_monitoring 13:02:22 INFO - Starting resource monitoring. 13:02:22 INFO - [mozharness: 2016-08-18 20:02:22.816541Z] Finished create-virtualenv step (success) 13:02:22 INFO - [mozharness: 2016-08-18 20:02:22.817059Z] Running install step. 13:02:22 INFO - Running pre-action listener: _resource_record_pre_action 13:02:22 INFO - Running main action method: install 13:02:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:02:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:02:23 INFO - Reading from file tmpfile_stdout 13:02:23 INFO - Detecting whether we're running mozinstall >=1.0... 13:02:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:02:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:02:23 INFO - Reading from file tmpfile_stdout 13:02:23 INFO - Output received: 13:02:23 INFO - Usage: mozinstall [options] installer 13:02:23 INFO - Options: 13:02:23 INFO - -h, --help show this help message and exit 13:02:23 INFO - -d DEST, --destination=DEST 13:02:23 INFO - Directory to install application into. [default: 13:02:23 INFO - "/builds/slave/test"] 13:02:23 INFO - --app=APP Application being installed. [default: firefox] 13:02:23 INFO - mkdir: /builds/slave/test/build/application 13:02:23 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'] 13:02:23 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 13:02:40 INFO - Reading from file tmpfile_stdout 13:02:40 INFO - Output received: 13:02:40 INFO - /builds/slave/test/build/application/firefox/firefox 13:02:40 INFO - Running post-action listener: _resource_record_post_action 13:02:40 INFO - [mozharness: 2016-08-18 20:02:40.088579Z] Finished install step (success) 13:02:40 INFO - [mozharness: 2016-08-18 20:02:40.088825Z] Running run-tests step. 13:02:40 INFO - Running pre-action listener: _resource_record_pre_action 13:02:40 INFO - Running main action method: run_tests 13:02:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:02:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:02:40 INFO - Python 2.7.3 13:02:40 INFO - Return code: 0 13:02:40 INFO - grabbing minidump binary from tooltool 13:02:40 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')]} 13:02:40 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 0x147c370>, '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 0x147f8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147fd80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:02:40 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 13:02:40 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 13:02:40 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 13:02:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:02:40 INFO - Return code: 0 13:02:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:02:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:02:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:02:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:02:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:02:40 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/ZjA3gEcrR_-l_pMB417TSg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 13:02:40 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/ZjA3gEcrR_-l_pMB417TSg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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 13:02:40 INFO - Using env: {'DISPLAY': ':0', 13:02:40 INFO - 'HOME': '/home/cltbld', 13:02:40 INFO - 'LANG': 'en_US.UTF-8', 13:02:40 INFO - 'LANGUAGE': 'en_US:en', 13:02:40 INFO - 'LOGNAME': 'cltbld', 13:02:40 INFO - 'MAIL': '/var/mail/cltbld', 13:02:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:02:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:02:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:40 INFO - 'MOZ_NO_REMOTE': '1', 13:02:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:02:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:02:40 INFO - 'NO_EM_RESTART': '1', 13:02:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:02:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:02:40 INFO - 'PWD': '/builds/slave/test', 13:02:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:02:40 INFO - 'SHELL': '/bin/bash', 13:02:40 INFO - 'SHLVL': '1', 13:02:40 INFO - 'TERM': 'linux', 13:02:40 INFO - 'TMOUT': '86400', 13:02:40 INFO - 'USER': 'cltbld', 13:02:40 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1471550502.828633-1541337525', 13:02:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:40 INFO - '_': '/tools/buildbot/bin/python'} 13:02:40 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/ZjA3gEcrR_-l_pMB417TSg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 13:02:40 INFO - mozversion application_buildid: 20160818113003 13:02:40 INFO - mozversion application_changeset: dce857dd57e2d91ae4c6014cf21e93ef95e4dd36 13:02:40 INFO - mozversion application_display_name: Nightly 13:02:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:02:40 INFO - mozversion application_name: Firefox 13:02:40 INFO - mozversion application_remotingname: firefox 13:02:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:02:40 INFO - mozversion application_vendor: Mozilla 13:02:40 INFO - mozversion application_version: 51.0a1 13:02:40 INFO - mozversion platform_buildid: 20160818113003 13:02:40 INFO - mozversion platform_changeset: dce857dd57e2d91ae4c6014cf21e93ef95e4dd36 13:02:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:02:40 INFO - mozversion platform_version: 51.0a1 13:02:40 INFO - using testdate: 1471550560 13:02:40 INFO - actual date: 1471550560 13:02:40 INFO - starting webserver on 'localhost:48285' 13:02:40 INFO - SUITE-START | Running 2 tests 13:02:40 INFO - TEST-START | dromaeo_css 13:02:40 INFO - operating with platform_type : linux_ 13:02:40 INFO - Initialising browser for dromaeo_css test... 13:02:40 INFO - TEST-INFO | started process 15079 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfl6YTK/profile http://localhost:48285/getInfo.html) 13:02:44 INFO - PROCESS | 15079 | __metrics Screen width/height:1600/1200 13:02:44 INFO - PROCESS | 15079 | colorDepth:24 13:02:44 INFO - PROCESS | 15079 | Browser inner width/height: 1024/697 13:02:44 INFO - PROCESS | 15079 | __metrics 13:02:45 INFO - PROCESS | 15079 | 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" 13:02:45 INFO - PROCESS | 15079 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:02:45 INFO - PROCESS | 15079 | console.error: PushService: 13:02:45 INFO - PROCESS | 15079 | stateChangeProcessEnqueue: Error transitioning state 13:02:45 INFO - PROCESS | 15079 | UnknownError 13:02:46 INFO - TEST-INFO | 15079: exit 0 13:02:46 INFO - Browser initialized. 13:02:46 INFO - Running cycle 1/1 for dromaeo_css test... 13:02:46 INFO - TEST-INFO | started process 15160 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfl6YTK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:02:58 INFO - PROCESS | 15160 | RSS: Main: 155566080 13:02:58 INFO - PROCESS | 15160 | 13:03:49 INFO - PROCESS | 15160 | 1471550629954 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] 13:05:59 INFO - PROCESS | 15160 | Cycle 1(1): loaded http://localhost:48285/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48285/tests/dromaeo/cssquery-ext.html) 13:06:00 INFO - PROCESS | 15160 | RSS: Main: 233943040 13:06:00 INFO - PROCESS | 15160 | 13:09:02 INFO - PROCESS | 15160 | Cycle 1(1): loaded http://localhost:48285/tests/dromaeo/cssquery-ext.html (next: http://localhost:48285/tests/dromaeo/cssquery-jquery.html) 13:09:03 INFO - PROCESS | 15160 | RSS: Main: 246046720 13:09:03 INFO - PROCESS | 15160 | 13:12:05 INFO - PROCESS | 15160 | Cycle 1(1): loaded http://localhost:48285/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48285/tests/dromaeo/cssquery-mootools.html) 13:12:05 INFO - PROCESS | 15160 | RSS: Main: 185245696 13:12:05 INFO - PROCESS | 15160 | 13:15:07 INFO - PROCESS | 15160 | Cycle 1(1): loaded http://localhost:48285/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48285/tests/dromaeo/cssquery-prototype.html) 13:15:08 INFO - PROCESS | 15160 | RSS: Main: 220426240 13:15:08 INFO - PROCESS | 15160 | 13:18:11 INFO - PROCESS | 15160 | Cycle 1(1): loaded http://localhost:48285/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48285/tests/dromaeo/cssquery-yui.html) 13:18:11 INFO - PROCESS | 15160 | RSS: Main: 187002880 13:18:11 INFO - PROCESS | 15160 | 13:21:14 INFO - PROCESS | 15160 | Cycle 1(1): loaded http://localhost:48285/tests/dromaeo/cssquery-yui.html (next: http://localhost:48285/tests/dromaeo/cssquery-dojo.html) 13:21:15 INFO - PROCESS | 15160 | RSS: Main: 268591104 13:21:15 INFO - PROCESS | 15160 | 13:21:15 INFO - PROCESS | 15160 | __start_tp_report 13:21:15 INFO - PROCESS | 15160 | _x_x_mozilla_page_load 13:21:15 INFO - PROCESS | 15160 | _x_x_mozilla_page_load_details 13:21:15 INFO - PROCESS | 15160 | |i|pagename|runs| 13:21:15 INFO - PROCESS | 15160 | |0;dojo.html;2987.0590763909368;3033.1658793831693;3036.3471853551487;3044.0411270449795;3049.5120780675097;5192.896142077157;5216.165413533835;5298.205269209616;5394.433584473632;5416.620836541439;5191.5327620514145;5255.500727430888;5263.657862238952;5284.577233821295;5352.170413585901;4660.091282199973;4759.048190361924;4761.142994261032;4766.73782941938;4920.237363208708;4844.709317440947;4873.951260487385;4890.682105663121;4892.9510704892855;4900.240462728283;4676.392069031038;4695.413073365829;4708.717476951377;4716.9292460613115;4837.661363704542;4793.712377257376;4794.616430685572;4798.232282834764;4806.966502202008;4916.287138364953;4813.903721925577;4838.201696720037;4839.104765618372;4855.46589875117;4871.658983871131;5216.452272511369;5271.209318602202;5285.418603953562;5286.392064912546;5358.303420555342;5661.716914154275;5677.545796336283;5679.204911312419;5701.486866182022;5710.400407957146;5657.434256574351;5693.28833895763;5722.399148089474;5763.452472015152;5765.308163020464;5137.61467889906;5185.507376799198;5283.630145889828;5290.259363689087;5375.704336261543;5845.1232315153065;5859.238299021185;5865.178874957509;5866.325372582208;5868.061110222344;5595.21666966625;5625.353084395265;5651.095824668033;5653.575981801299;5656.745446454919;5514.228008078872;5547.057000309957;5576.693281869536;5578.97210513953;5673.1490276458035;5590.133529302883;5593.8321850344555;5594.692291923902;5596.3284405870745;5623;5556.249906262603;5590.8043218487155;5601.887962240732;5606.243157173811;5606.719664016783;4222;4309.353596960418;4309.84915527955;4367.58507941745;4367.890802729894;3907.0427745202605;3930.567637559866;3932.508436445444;3933.3116704576582;3933.6853051755793;5252.737363131828;5304.363476382859;5317.840464785985;5355.437679043722;5399.433059528771;5632.211490391349;5639.154126881001;5653.180288858175;5661.377248502661;5673.120666296731;5164.535191832678;5235.633505654644;5297.682139071668;5306.151015837448;5310.336207974004;4840.298156767249;4854.5873600744335;4858.05267972749;4881.804727810848;4888.413390393175;5815.244018277597;5831.504322132581;5840.977828879929;5846.298444186725;5846.444587764156;5456.781728730965;5596.076647353304;5651.971740141273;5656.123300888369;5659.490645841894;5736.110902810071;5821.970890145522;5837.270341207349;5885.705714714333;5952.910706339322;5592.412796656456;5596.86007849807;5601.04782187021;5604.3835178131185;5608.551315894637;5539.806106786243;5709.400512946081;5726.599138060463;5730.025895597675;5736.971315143398;5437.8368648940595;5518.061929471919;5543.085390910454;5588.13383925476;5631.971840140773;5439.646422982493;5480.616356854982;5483.917741233805;5484.61607687458;5496.642718223303;5272.78908843642;5421.810236641699;5430.592705547178;5432.239486471976;5474.275603184984;5550.084236100998;5595.328560572757;5637.88724225505;5639.013172694844;5643.097104463266;5459.153831156177;5481.232627432083;5481.506664400223;5482.150266708666;5482.725863706719 13:21:15 INFO - PROCESS | 15160 | |1;ext.html;600.1807532717838;607.3653032580954;618.3538202578305;624.5596854217777;645.6190847400034;42756.78621606892;43896.78051609745;43920.12159756811;44231.55768442315;47859.28211076836;45519;46001.539984600226;46003.53996460034;46033.53966460334;46050.539494605044;8873.201411872946;8967.551622418885;8971.46171229725;9012.053734357896;9017.954910225473;8877.422967507124;8965.417247878899;8969.95515022424;8972.820543589158;8978.50618215998;9005.594748236344;9073.682421115262;9078.77303067422;9083.046280140588;9084.682036128737;8979.865302020442;9004.819903601956;9020.77448063797;9021.684241051564;9024.684136055206;8935.64257429702;9005.369624126313;9007.729768106967;9008.77478063047;9009.684661036832;43716.562834371565;44030.33954490685;44076.016579253686;44178.33732494015;44209;3500.8035776675397;3632.9636703633155;3753.11801726594;4040.434339192486;4325.740455572644;31863;32272.6772732272;33171.50242746361;33223.66776332254;33393;4341.913161736779;4450.443694538183;4452.421185245929;4648.604868586174;4650.465196502378;348207;349505;349911;350863;351046.24476877705;58470;58954.70522647359;59185.70407148023;59266;59365.70317148387;61636;61753.691231543555;61860.38139618636;61878;61894.0484761218;16571;16812.915935420246;16829.242684079247;16842.915785420995;16844.07357595344;12982.221066736027;13031.804522932163;13062.281574513492;13075.280859552817;13075.738485230242;15856.60358491047;16484.42304519336;16484.42304519336;16714.331426742796;16831.41090061842;6501.642409667514;6568.67156642166;6671.132752742113;6719.798406047827;6761.864762704817;952.8856537215579;1020.2501161646184;1047.2145890582065;1112.5994641928899;1134.6709454258337;33321;33890.32219355649;33905.49141762876;33930.49104263438;34461;1103.489264753232;1137.1641843245209;1160.3675996581883;1172.3317708906013;1254.5489846616438;17678.348247762682;17679;17694.91152544229;17728.202230899642;17779.73330400045;517911;518654.40672796394;518832;520086;520137;60089.39910600838;60354;60566.394336056954;60707;60735.69632151899;1244.6577191272293;1336.3652265173964;1384.4323827230787;1389.083205084619;1412.6044707481922;31749;34815;35058.298834023684;35082.64917350794;35149.47275790814;51284.48715512797;52024;52151.73924130355;52170.739146304026;52186.73906630594;305364;305960;306143;307283;307441;41899.162016758884;42589;42977;43213.78393108014;43453;49112.263316049575;49574.256386153516;50125.74937125291;50276.737546811215;50691.74654126706;39154.6084539151;40781.79609101936;41450;43626.56373436225;43875;41968.16063678648;42033.36949945692;42090.368644469745;43375.34936976011;43792.562074378846;42831.1433771329;42862;44373.11253774842;44542.331865021406;44546.3318050223;35263.471047934814;38135.80932095433;38455.61544384521;38518.614813851505;39042.609573903894;29194.7080529192;29398.265043374086;29519.55720664235;29556.391721952838;29752.256193595334 13:21:15 INFO - PROCESS | 15160 | |2;jquery.html;378.10389377176097;392.60543154130096;405.78696184503144;408.51590864825187;425.0245686150285;13970.580882573513;18461;19254;19668.508287292825;19732.210711571537;12952.80570791439;13088.93455532721;13140.14589051711;13236.404361803718;13239.867601323984;3942.3889297158985;5048.066107770056;5174.068667639824;5176.352955880515;5177.145770947808;5632.5212356949505;5854.76580936762;5902.763889444417;5979.551533634973;5985.730642121115;5940.287165540141;5978.910316345258;5993.580449368546;6470.967645161768;6527.379898909596;6342.968285158568;6446.452051575622;6472.255690595594;6472.35276472349;6486.740530378779;5591.3569939456665;5724.656520608735;5773.336066352381;5774.700692344231;5778.566607504454;14578.12531248118;14694.55916322512;17952.551186220448;23346.416339591477;23627;2246.4271610739156;2325.9651105233434;2445.9510809783706;2586.301698541402;2822.8849604406146;10771;11017.724556886062;11030.28303160292;11593.710157246052;14120.71758564823;1952.9609407811906;2024.5039965208618;2028.4523178741804;2029.6752519596942;2035.0740413111998;74903;81715;81836.59081704554;83207.5839620804;83690;10907.945460272647;11010.229283950206;11191.019996101657;11286;11484.540618375338;15392;15433.922830386;15436.305366258546;15437.459688911058;15446.459373921858;7483.8877416838795;7559.3196612304055;7800.414968877357;7807.765767026998;7870.645820938072;7182.174049984214;7190.568565886064;7194.244604316471;7415.1472580652835;7431.2197219292275;4699.459562150328;4739.102532457957;4822.9758851206225;4918.11473934688;4996.7501624918605;1945.6497830390383;1985.4043786864172;2041.530447996969;2041.7243672104075;2068.586282743427;960.3722187978441;964.9710508684751;974.8830140383058;978.1392374710209;996.4619105682995;19577.608447830964;19901.60196796056;19971.301004464774;20102.49743756418;20144.49638759043;954.4559601027487;969.5927710361665;978.7210644966293;1015.9796804063877;1024.5082360467018;10436.37381757097;10442.796000039776;10986.670399888017;10999.335956470448;11015.669529914116;471410;472865;477416;479134;479205;59157.70421147867;61920;92369;96132;97139;928.1414691410554;928.5403725156091;953.5232383808096;954.117441366733;972.1105188752213;16812.747808783122;17028.744568831724;17771.378001769877;17881.821181788535;17963.820361796737;41759.164816704106;41812.58187418087;42084.57915420806;42402.15195696007;42621.78689106535;52274.477255228485;55681.72159139178;56551.15173272322;56600.716996414754;57076.59395805446;5535.944640553704;8363.375624912744;8423.70517031901;8464.518709225738;8829.293656507592;11030.448477575928;12017;12398.25610463375;12710.173838700455;12853.421596028014;11132.944335278271;11334.206605537533;11636.185467017227;11690.240134391237;11709.590164344207;11001.504932277907;11014.39420831862;11054.281471704313;11303.491342889754;11765.823512647488;11225.49485273181;11451.885481145082;11511.136664750009;11558.711032224262;11615.186936914335;7661.885071723817;7801.102873169658;8398.622062007347;8402.621882015446;8704.825903481767;11562.364069976233;11583.478743456397;11745.647630571097;11774.175807693722;12374.690632734253 13:21:15 INFO - PROCESS | 15160 | |3;mootools.html;1324.8277723895892;1469.816272965879;1473.0866862545224;1614.677064587083;1758.621896292296;8282.461639993397;8637.91362086379;8715.302775777938;8912.821743565124;8994.955025224865;8750.6937257196;8857.42426742263;8861.291096712264;8862.64549418024;8866.911330886705;2016.9899150504227;2303.34354708908;2352.529494101178;2385.5586716457424;2386.95226095478;2388.7969522590515;2406.9398265043337;2411.7829395354415;2415.927522174338;2419.346776370379;2329;2336.6144586143264;2348.518553696488;2354.7174339079334;2369.3365857559825;2244.136007637055;2297.7242730872317;2310.6880571122933;2310.838241323108;2331.5103828196097;2373.7626237376126;2391.210900402863;2392.1986134644917;2397.208921056065;2397.7602239776056;8865.955670221607;8917.331200160013;8922.464652120894;8924.732258032269;8930.151635594608;5251.55361794248;5301.655392399482;5443.537299329561;5446.046941785172;5449.964506743706;3311.850966706504;3421.8289085545625;3454.360943225511;3497.3704733148024;3500.824958752052;1059.7071572681316;1113.6269349767838;1152.6426807689643;1163.8661553921238;1169.6549517892242;12467.438965246585;12521.56174533896;12552.74050670879;12583.937080314632;12588.496460141583;4410.1400226956075;4583.862484125481;4752.477227504972;4760.071786001766;4776.164171270014;9772.706818795305;9787.314887957775;9790.06994335537;9793.069658382443;9814.116729494237;5398.325209348832;5408.432114627986;5409.161579955114;5411.269478620336;5413.188021796762;4396.780160991938;4830.782614782343;4969.975150124298;5036;5055.747212639353;3651.580068292127;3782.6973842093116;3796.088938654703;3813.103920578662;3869.6710779583486;1104.8508451359126;1154.417019405195;1157.9231314877245;1166.8249762535518;1182.8876256755595;883.4522595990527;945.8439357505935;958.152035448633;965.710286913923;1000.4497526360473;5948.762049518057;6156.8768624627255;6193.256809182837;6363.809085727436;6386.042093685985;464.7745843266013;488.5822621658431;491.8327768558636;1031.5203430404897;1140.372794962767;3915.804209789556;4088.5707000765087;4108.1783643271465;4203.117345357448;4322.24360736876;10789.676309710721;10985.61550345734;11089.944550277358;11101.111911047097;11118.666440006813;10978.396188209725;10981.725456863642;10992;11026.228164028602;11048.944755276172;8153.510789352657;8238.588070596446;8266.545340006238;8269.09040005599;8282.917170828214;6090.9390906090375;6116.532032312124;6184.072389141665;6224.066390041349;6283.434490895841;10099.091081802673;10117.392956422638;10127.291089623655;10173.08442240202;10237.692869213935;10181.796364072825;10409.137487191083;10482.895171048192;10568.788624227625;10584.4707764613;7239.819004524718;7658.540487570764;7821.061472623322;8057.879131813144;8267.669293228204;8419.158084191777;8722.433041852513;8725.3892227546;8727.127287271222;8731.869021964803;7594.31651151399;7626.161122276434;7732.9226707732205;7862.371010319275;7969.6015199238645;7451.813704657427;7597.240275972579;7648.923510764821;7684.807879802826;7749.845003099794;6882.621455819978;6968;6988.510804243654;6990.965045174741;6996.335348141918;5279.788808447619;5308.416074231909;5346.518813306821;5361.4370491099435;5614.719264036864;5381.354237491526;5408.891822163613;5493.368262649847;5537.141743029837;5562.3313006098815 13:21:15 INFO - PROCESS | 15160 | |4;prototype.html;321.10411950657664;330.24868424334636;332.49294825391274;344.60370573840083;345.6077352205246;5243.8689032774155;5267.683938963655;5268.31511903453;5286.867828304289;5298.549623282026;4950.356453661028;4982;5066.873328166797;5102.438731739506;5220.530152286294;4047.9797601011956;4095.5051406236657;4109.486314210723;4130.8141133648905;4131.876043718693;4108.938365924513;4119.917601647965;4125.484314460692;4128.772917489537;4144.689148313873;3871.8644847430346;3874.786886721229;4046.372812214097;4062.106336605942;4075.286824805662;4013.5585085640555;4046.309204379114;4049.129437170993;4058.269511487916;4065.8373665053364;3619.7828130312;3629.745917785756;3634.127809325743;3646.690031347339;3652.5982141964364;4786.904261914742;5099.235114732783;5116.923246151311;5127.077126117298;5183.248428977777;4670.252759558454;4681.133990211822;4683.1336202802595;4683.431050598054;4746.935083238802;5392.548768787979;5413.188021796762;5425.294711687495;5468.835934921919;5483.588730845203;3813.80930953454;3997.8600748973645;4078.7348822326453;4079.3269110596716;4086.836526538935;5616.52259557938;5635.830925072254;5643.238162848045;5656.575756818255;5660.433956604306;4086.346184610448;4095.447114639545;4106.938395924063;4118.464599602033;4135.152293779768;3987;4173.624373806311;4178.143480586473;4179;4190.664746820247;4664.160451118832;4664.183767840615;4669.136209801198;4703.17694403478;4716.622670186377;5431.103867861759;5438.8912221755345;5449.536789372948;5488.945110548843;5517.917231241535;1335.30564106664;1434.8278206615273;1446.8191476065492;1451.3396404635864;1458.6790906000663;916.9128932751378;955.8375076237056;972.8929817720045;975.6146322202691;977.1742877268697;4450.955490445119;4649.349091127245;4652.232381656989;4686.5782079613;4694.882627934329;4916.418880087911;4943.184374578154;4944.60443164546;4950.727709975914;4952.504749525018;4617.746023968714;4663.300504924221;4679.789409476582;4689.20283551797;4698.580231180945;2514.5976643736913;2620.174644986823;2637.709851916288;2646.2193652872447;2649.205238428502;5028.874278143003;5038.949610503848;5061.392632884077;5066.620003499752;5083.297095473058;5040.4455509894615;5047.369078865142;5064.898702025939;5095.210242412432;5123.564497017721;5097.903950650554;5113.593761715483;5130.948690513122;5371.462853714597;5803;5649.915251271316;5651.88696226065;5654.06707893193;5654.293213348332;5666.829995100154;5575.888482230252;5599.076152434803;5599.188117722989;5617.578681598815;5639.520640745583;5596.188552659923;5726.427357264407;5757.539396848326;5771.239771869452;5778.768849245983;3987.6610488108836;4009.8195581198333;4030;4033.757974521538;4052.682878064582;5388.568914486753;5492.407201911401;5531.446855314436;5582.665040097607;5645.71771411436;5405.72971351423;5431.646942948696;5437.13005919051;5437.483439073281;5441.238226648194;5258.184981327748;5426.07756681373;5442.496451632293;5455.509004189642;5475.67145971243;5383.757730902197;5387.622866399314;5419.160030195326;5421.403645598902;5425.647332923348;5484.232207490874;5520;5524.111161621913;5524.364698059614;5530.1197592818635;5198.922016169685;5313.203019546944;5365.892682146413;5401.3248343957;5406.5945054121885 13:21:15 INFO - PROCESS | 15160 | |5;yui.html;769.8743103001813;794.638439510023;822.7038266224162;831.2103501673408;843.7131375332385;14985;16146.515604531853;16161.595960101004;16196.919015404907;16318.265678044487;14567.635809104777;14753;14993;15006.774898376505;15015.624609384771;794.1264608930173;799.0890384961149;807.1484583764127;807.3581502705334;807.8990126234221;644.4940721533598;759.3014426727397;800.6397121295412;805.3074356053789;805.5448671500612;862.2886118951858;876.8684697295425;876.9868451973225;877.0133599700337;877.2587163846539;872.0233338660709;872.145297608341;872.4416373520984;872.4852337121097;872.7861673889875;494.69081823860085;585.6983653418492;633.5375176121411;633.7053270229366;633.7179954920063;15212.543623691196;15486.22568871552;15514.456994005268;15519.612009699847;15524.534263972098;13918;14096.644509015565;14562.563123106323;14761.33573989173;14822.925885370503;13163;13250.933745331307;13409.717590610815;13666.385012674453;13849.307534623229;4489.0023939347;4556.954430455686;4565.452145742533;4737.905241895177;4765.26138448541;79925.60037199777;80323.19676803274;81432.59283703544;82796.75804862993;83617;11425.828612570818;11425.942870285762;11474.196806223485;11684;12217.083718720954;22137.557248855253;22149.224777133044;22197.55604887893;22212;22243.555128897657;7981.48120372174;8242.835143297101;8348.33213342931;8548.358873084544;8787.12128787129;4773.546513081252;4817.638677099231;4848.515148485123;4947.35684361038;5097.515736005073;3451.9827400862837;3831.1762970961377;4058.411530328086;4059.5331536873045;4063.6545893599377;742.3133601418666;754.7169811320755;755.1466842467976;759.400073941591;759.9620018999028;570.8258981010748;614.5636598015459;648.5298158834808;753.7173559915032;792.8335049639641;9937.701868943943;10254.794904101876;10494.68515944523;10620.734481638021;10674.839877401846;704.7568588836843;706.3254591864757;718.2007182007228;718.5939943931662;731.1226528166222;4996.931796071646;5219.347581552306;5231.267622532849;5262.184361423985;5286.788528458818;103661;126303;127399;131062;131456;107473.24913662582;109499;110697;112866.43566782278;114967.42516287365;56881.431185687616;59349.70325148433;75968.62015689886;92548;95855;9825.459599722084;10295.433751143759;10436.269461137648;10478.738031549272;10642.62750803749;51659;52649.736751317534;53356.1996570044;53569;54435;67388;72939.63530182315;73101.26898730945;73373.633131834;77709;13556.59330220095;13770.793438098237;13905.582832515041;14155.962756348128;14198.219097949712;15287.61780955485;15483.612909677347;15511.5346539604;15954.202289885692;15978.360865565248;14512.927435362755;14818.481353152589;14884.181370024753;14992.400303987719;15084.924575377054;14418.062825916282;14657.48698795537;14827.258637068318;14901.776473353126;15657.530274091796;14585.92707036458;14848.951356538828;15571.221438928234;15614.765778513558;15667.608309792346;11754.76490470203;11844.585439509576;12271.57049503263;12362.876371236172;12439.253644781342;10045.49772511357;11434.313941163557;12546.247225166519;12638.494460221857;12651.597446466396 13:21:15 INFO - PROCESS | 15160 | __end_tp_report 13:21:15 INFO - PROCESS | 15160 | __start_cc_report 13:21:15 INFO - PROCESS | 15160 | _x_x_mozilla_cycle_collect,1050 13:21:15 INFO - PROCESS | 15160 | __end_cc_report 13:21:15 INFO - PROCESS | 15160 | __startTimestamp1471551675114__endTimestamp 13:21:15 INFO - PROCESS | 15160 | 13:21:15 INFO - PROCESS | 15160 | ------- Summary: start ------- 13:21:15 INFO - PROCESS | 15160 | Number of tests: 6 13:21:15 INFO - PROCESS | 15160 | 13:21:15 INFO - PROCESS | 15160 | [#0] dojo.html Cycles:165 Average:5251.62 Median:5459.15 stddev:597.26 (10.9%) stddev-sans-first:572.06 13:21:15 INFO - PROCESS | 15160 | Values: 2987.1 3033.2 3036.3 3044.0 3049.5 5192.9 5216.2 5298.2 5394.4 5416.6 5191.5 5255.5 5263.7 5284.6 5352.2 4660.1 4759.0 4761.1 4766.7 4920.2 4844.7 4874.0 4890.7 4893.0 4900.2 4676.4 4695.4 4708.7 4716.9 4837.7 4793.7 4794.6 4798.2 4807.0 4916.3 4813.9 4838.2 4839.1 4855.5 4871.7 5216.5 5271.2 5285.4 5286.4 5358.3 5661.7 5677.5 5679.2 5701.5 5710.4 5657.4 5693.3 5722.4 5763.5 5765.3 5137.6 5185.5 5283.6 5290.3 5375.7 5845.1 5859.2 5865.2 5866.3 5868.1 5595.2 5625.4 5651.1 5653.6 5656.7 5514.2 5547.1 5576.7 5579.0 5673.1 5590.1 5593.8 5594.7 5596.3 5623.0 5556.2 5590.8 5601.9 5606.2 5606.7 4222.0 4309.4 4309.8 4367.6 4367.9 3907.0 3930.6 3932.5 3933.3 3933.7 5252.7 5304.4 5317.8 5355.4 5399.4 5632.2 5639.2 5653.2 5661.4 5673.1 5164.5 5235.6 5297.7 5306.2 5310.3 4840.3 4854.6 4858.1 4881.8 4888.4 5815.2 5831.5 5841.0 5846.3 5846.4 5456.8 5596.1 5652.0 5656.1 5659.5 5736.1 5822.0 5837.3 5885.7 5952.9 5592.4 5596.9 5601.0 5604.4 5608.6 5539.8 5709.4 5726.6 5730.0 5737.0 5437.8 5518.1 5543.1 5588.1 5632.0 5439.6 5480.6 5483.9 5484.6 5496.6 5272.8 5421.8 5430.6 5432.2 5474.3 5550.1 5595.3 5637.9 5639.0 5643.1 5459.2 5481.2 5481.5 5482.2 5482.7 13:21:15 INFO - PROCESS | 15160 | 13:21:15 INFO - PROCESS | 15160 | [#1] ext.html Cycles:180 Average:57248.27 Median:43671.56 stddev:106310.30 (243.4%) stddev-sans-first:106523.45 13:21:15 INFO - PROCESS | 15160 | Values: 600.2 607.4 618.4 624.6 645.6 42756.8 43896.8 43920.1 44231.6 47859.3 45519.0 46001.5 46003.5 46033.5 46050.5 8873.2 8967.6 8971.5 9012.1 9018.0 8877.4 8965.4 8970.0 8972.8 8978.5 9005.6 9073.7 9078.8 9083.0 9084.7 8979.9 9004.8 9020.8 9021.7 9024.7 8935.6 9005.4 9007.7 9008.8 9009.7 43716.6 44030.3 44076.0 44178.3 44209.0 3500.8 3633.0 3753.1 4040.4 4325.7 31863.0 32272.7 33171.5 33223.7 33393.0 4341.9 4450.4 4452.4 4648.6 4650.5 348207.0 349505.0 349911.0 350863.0 351046.2 58470.0 58954.7 59185.7 59266.0 59365.7 61636.0 61753.7 61860.4 61878.0 61894.0 16571.0 16812.9 16829.2 16842.9 16844.1 12982.2 13031.8 13062.3 13075.3 13075.7 15856.6 16484.4 16484.4 16714.3 16831.4 6501.6 6568.7 6671.1 6719.8 6761.9 952.9 1020.3 1047.2 1112.6 1134.7 33321.0 33890.3 33905.5 33930.5 34461.0 1103.5 1137.2 1160.4 1172.3 1254.5 17678.3 17679.0 17694.9 17728.2 17779.7 517911.0 518654.4 518832.0 520086.0 520137.0 60089.4 60354.0 60566.4 60707.0 60735.7 1244.7 1336.4 1384.4 1389.1 1412.6 31749.0 34815.0 35058.3 35082.6 35149.5 51284.5 52024.0 52151.7 52170.7 52186.7 305364.0 305960.0 306143.0 307283.0 307441.0 41899.2 42589.0 42977.0 43213.8 43453.0 49112.3 49574.3 50125.7 50276.7 50691.7 39154.6 40781.8 41450.0 43626.6 43875.0 41968.2 42033.4 42090.4 43375.3 43792.6 42831.1 42862.0 44373.1 44542.3 44546.3 35263.5 38135.8 38455.6 38518.6 39042.6 29194.7 29398.3 29519.6 29556.4 29752.3 13:21:15 INFO - PROCESS | 15160 | 13:21:15 INFO - PROCESS | 15160 | [#2] jquery.html Cycles:180 Average:27944.72 Median:407.15 stddev:78423.94 (19261.6%) stddev-sans-first:78616.63 13:21:15 INFO - PROCESS | 15160 | Values: 378.1 392.6 405.8 408.5 425.0 13970.6 18461.0 19254.0 19668.5 19732.2 12952.8 13088.9 13140.1 13236.4 13239.9 3942.4 5048.1 5174.1 5176.4 5177.1 5632.5 5854.8 5902.8 5979.6 5985.7 5940.3 5978.9 5993.6 6471.0 6527.4 6343.0 6446.5 6472.3 6472.4 6486.7 5591.4 5724.7 5773.3 5774.7 5778.6 14578.1 14694.6 17952.6 23346.4 23627.0 2246.4 2326.0 2446.0 2586.3 2822.9 10771.0 11017.7 11030.3 11593.7 14120.7 1953.0 2024.5 2028.5 2029.7 2035.1 74903.0 81715.0 81836.6 83207.6 83690.0 10907.9 11010.2 11191.0 11286.0 11484.5 15392.0 15433.9 15436.3 15437.5 15446.5 7483.9 7559.3 7800.4 7807.8 7870.6 7182.2 7190.6 7194.2 7415.1 7431.2 4699.5 4739.1 4823.0 4918.1 4996.8 1945.6 1985.4 2041.5 2041.7 2068.6 960.4 965.0 974.9 978.1 996.5 19577.6 19901.6 19971.3 20102.5 20144.5 954.5 969.6 978.7 1016.0 1024.5 10436.4 10442.8 10986.7 10999.3 11015.7 471410.0 472865.0 477416.0 479134.0 479205.0 59157.7 61920.0 92369.0 96132.0 97139.0 928.1 928.5 953.5 954.1 972.1 16812.7 17028.7 17771.4 17881.8 17963.8 41759.2 41812.6 42084.6 42402.2 42621.8 52274.5 55681.7 56551.2 56600.7 57076.6 5535.9 8363.4 8423.7 8464.5 8829.3 11030.4 12017.0 12398.3 12710.2 12853.4 11132.9 11334.2 11636.2 11690.2 11709.6 11001.5 11014.4 11054.3 11303.5 11765.8 11225.5 11451.9 11511.1 11558.7 11615.2 7661.9 7801.1 8398.6 8402.6 8704.8 11562.4 11583.5 11745.6 11774.2 12374.7 13:21:15 INFO - PROCESS | 15160 | 13:21:15 INFO - PROCESS | 15160 | [#3] mootools.html Cycles:180 Average:5849.95 Median:2659.68 stddev:3329.84 (125.2%) stddev-sans-first:3321.82 13:21:15 INFO - PROCESS | 15160 | Values: 1324.8 1469.8 1473.1 1614.7 1758.6 8282.5 8637.9 8715.3 8912.8 8995.0 8750.7 8857.4 8861.3 8862.6 8866.9 2017.0 2303.3 2352.5 2385.6 2387.0 2388.8 2406.9 2411.8 2415.9 2419.3 2329.0 2336.6 2348.5 2354.7 2369.3 2244.1 2297.7 2310.7 2310.8 2331.5 2373.8 2391.2 2392.2 2397.2 2397.8 8866.0 8917.3 8922.5 8924.7 8930.2 5251.6 5301.7 5443.5 5446.0 5450.0 3311.9 3421.8 3454.4 3497.4 3500.8 1059.7 1113.6 1152.6 1163.9 1169.7 12467.4 12521.6 12552.7 12583.9 12588.5 4410.1 4583.9 4752.5 4760.1 4776.2 9772.7 9787.3 9790.1 9793.1 9814.1 5398.3 5408.4 5409.2 5411.3 5413.2 4396.8 4830.8 4970.0 5036.0 5055.7 3651.6 3782.7 3796.1 3813.1 3869.7 1104.9 1154.4 1157.9 1166.8 1182.9 883.5 945.8 958.2 965.7 1000.4 5948.8 6156.9 6193.3 6363.8 6386.0 464.8 488.6 491.8 1031.5 1140.4 3915.8 4088.6 4108.2 4203.1 4322.2 10789.7 10985.6 11089.9 11101.1 11118.7 10978.4 10981.7 10992.0 11026.2 11048.9 8153.5 8238.6 8266.5 8269.1 8282.9 6090.9 6116.5 6184.1 6224.1 6283.4 10099.1 10117.4 10127.3 10173.1 10237.7 10181.8 10409.1 10482.9 10568.8 10584.5 7239.8 7658.5 7821.1 8057.9 8267.7 8419.2 8722.4 8725.4 8727.1 8731.9 7594.3 7626.2 7732.9 7862.4 7969.6 7451.8 7597.2 7648.9 7684.8 7749.8 6882.6 6968.0 6988.5 6991.0 6996.3 5279.8 5308.4 5346.5 5361.4 5614.7 5381.4 5408.9 5493.4 5537.1 5562.3 13:21:15 INFO - PROCESS | 15160 | 13:21:15 INFO - PROCESS | 15160 | [#4] prototype.html Cycles:180 Average:4503.55 Median:5043.91 stddev:1301.54 (25.8%) stddev-sans-first:1266.77 13:21:15 INFO - PROCESS | 15160 | Values: 321.1 330.2 332.5 344.6 345.6 5243.9 5267.7 5268.3 5286.9 5298.5 4950.4 4982.0 5066.9 5102.4 5220.5 4048.0 4095.5 4109.5 4130.8 4131.9 4108.9 4119.9 4125.5 4128.8 4144.7 3871.9 3874.8 4046.4 4062.1 4075.3 4013.6 4046.3 4049.1 4058.3 4065.8 3619.8 3629.7 3634.1 3646.7 3652.6 4786.9 5099.2 5116.9 5127.1 5183.2 4670.3 4681.1 4683.1 4683.4 4746.9 5392.5 5413.2 5425.3 5468.8 5483.6 3813.8 3997.9 4078.7 4079.3 4086.8 5616.5 5635.8 5643.2 5656.6 5660.4 4086.3 4095.4 4106.9 4118.5 4135.2 3987.0 4173.6 4178.1 4179.0 4190.7 4664.2 4664.2 4669.1 4703.2 4716.6 5431.1 5438.9 5449.5 5488.9 5517.9 1335.3 1434.8 1446.8 1451.3 1458.7 916.9 955.8 972.9 975.6 977.2 4451.0 4649.3 4652.2 4686.6 4694.9 4916.4 4943.2 4944.6 4950.7 4952.5 4617.7 4663.3 4679.8 4689.2 4698.6 2514.6 2620.2 2637.7 2646.2 2649.2 5028.9 5038.9 5061.4 5066.6 5083.3 5040.4 5047.4 5064.9 5095.2 5123.6 5097.9 5113.6 5130.9 5371.5 5803.0 5649.9 5651.9 5654.1 5654.3 5666.8 5575.9 5599.1 5599.2 5617.6 5639.5 5596.2 5726.4 5757.5 5771.2 5778.8 3987.7 4009.8 4030.0 4033.8 4052.7 5388.6 5492.4 5531.4 5582.7 5645.7 5405.7 5431.6 5437.1 5437.5 5441.2 5258.2 5426.1 5442.5 5455.5 5475.7 5383.8 5387.6 5419.2 5421.4 5425.6 5484.2 5520.0 5524.1 5524.4 5530.1 5198.9 5313.2 5365.9 5401.3 5406.6 13:21:15 INFO - PROCESS | 15160 | 13:21:15 INFO - PROCESS | 15160 | [#5] yui.html Cycles:180 Average:21667.41 Median:4058.97 stddev:31405.82 (773.7%) stddev-sans-first:31454.73 13:21:15 INFO - PROCESS | 15160 | Values: 769.9 794.6 822.7 831.2 843.7 14985.0 16146.5 16161.6 16196.9 16318.3 14567.6 14753.0 14993.0 15006.8 15015.6 794.1 799.1 807.1 807.4 807.9 644.5 759.3 800.6 805.3 805.5 862.3 876.9 877.0 877.0 877.3 872.0 872.1 872.4 872.5 872.8 494.7 585.7 633.5 633.7 633.7 15212.5 15486.2 15514.5 15519.6 15524.5 13918.0 14096.6 14562.6 14761.3 14822.9 13163.0 13250.9 13409.7 13666.4 13849.3 4489.0 4557.0 4565.5 4737.9 4765.3 79925.6 80323.2 81432.6 82796.8 83617.0 11425.8 11425.9 11474.2 11684.0 12217.1 22137.6 22149.2 22197.6 22212.0 22243.6 7981.5 8242.8 8348.3 8548.4 8787.1 4773.5 4817.6 4848.5 4947.4 5097.5 3452.0 3831.2 4058.4 4059.5 4063.7 742.3 754.7 755.1 759.4 760.0 570.8 614.6 648.5 753.7 792.8 9937.7 10254.8 10494.7 10620.7 10674.8 704.8 706.3 718.2 718.6 731.1 4996.9 5219.3 5231.3 5262.2 5286.8 103661.0 126303.0 127399.0 131062.0 131456.0 107473.2 109499.0 110697.0 112866.4 114967.4 56881.4 59349.7 75968.6 92548.0 95855.0 9825.5 10295.4 10436.3 10478.7 10642.6 51659.0 52649.7 53356.2 53569.0 54435.0 67388.0 72939.6 73101.3 73373.6 77709.0 13556.6 13770.8 13905.6 14156.0 14198.2 15287.6 15483.6 15511.5 15954.2 15978.4 14512.9 14818.5 14884.2 14992.4 15084.9 14418.1 14657.5 14827.3 14901.8 15657.5 14585.9 14849.0 15571.2 15614.8 15667.6 11754.8 11844.6 12271.6 12362.9 12439.3 10045.5 11434.3 12546.2 12638.5 12651.6 13:21:15 INFO - PROCESS | 15160 | -------- Summary: end -------- 13:21:15 INFO - PROCESS | 15160 | 13:21:15 INFO - TEST-INFO | 15160: exit 0 13:21:15 INFO - TEST-OK | dromaeo_css | took 1115586ms 13:21:15 INFO - TEST-START | kraken 13:21:15 INFO - operating with platform_type : linux_ 13:21:15 INFO - Initialising browser for kraken test... 13:21:15 INFO - TEST-INFO | started process 15470 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJzQKSC/profile http://localhost:48285/getInfo.html) 13:21:20 INFO - PROCESS | 15470 | __metrics Screen width/height:1600/1200 13:21:20 INFO - PROCESS | 15470 | colorDepth:24 13:21:20 INFO - PROCESS | 15470 | Browser inner width/height: 1024/697 13:21:20 INFO - PROCESS | 15470 | __metrics 13:21:20 INFO - PROCESS | 15470 | 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" 13:21:20 INFO - PROCESS | 15470 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:21:21 INFO - PROCESS | 15470 | console.error: PushService: 13:21:21 INFO - PROCESS | 15470 | stateChangeProcessEnqueue: Error transitioning state 13:21:21 INFO - PROCESS | 15470 | UnknownError 13:21:21 INFO - TEST-INFO | 15470: exit 0 13:21:21 INFO - Browser initialized. 13:21:21 INFO - Running cycle 1/1 for kraken test... 13:21:21 INFO - TEST-INFO | started process 15550 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJzQKSC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:21:33 INFO - PROCESS | 15550 | RSS: Main: 155742208 13:21:33 INFO - PROCESS | 15550 | 13:21:36 INFO - PROCESS | 15550 | Cycle 1(1): loaded http://localhost:48285/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48285/tests/kraken/driver.html?testName=audio-beat-detection) 13:21:37 INFO - PROCESS | 15550 | RSS: Main: 203743232 13:21:37 INFO - PROCESS | 15550 | 13:21:39 INFO - PROCESS | 15550 | Cycle 1(1): loaded http://localhost:48285/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48285/tests/kraken/driver.html?testName=audio-dft) 13:21:40 INFO - PROCESS | 15550 | RSS: Main: 194973696 13:21:40 INFO - PROCESS | 15550 | 13:21:43 INFO - PROCESS | 15550 | Cycle 1(1): loaded http://localhost:48285/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48285/tests/kraken/driver.html?testName=audio-fft) 13:21:43 INFO - PROCESS | 15550 | RSS: Main: 275542016 13:21:43 INFO - PROCESS | 15550 | 13:21:45 INFO - PROCESS | 15550 | Cycle 1(1): loaded http://localhost:48285/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48285/tests/kraken/driver.html?testName=audio-oscillator) 13:21:46 INFO - PROCESS | 15550 | RSS: Main: 186019840 13:21:46 INFO - PROCESS | 15550 | 13:21:48 INFO - PROCESS | 15550 | Cycle 1(1): loaded http://localhost:48285/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48285/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:21:49 INFO - PROCESS | 15550 | RSS: Main: 190730240 13:21:49 INFO - PROCESS | 15550 | 13:21:52 INFO - PROCESS | 15550 | Cycle 1(1): loaded http://localhost:48285/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48285/tests/kraken/driver.html?testName=imaging-darkroom) 13:21:52 INFO - PROCESS | 15550 | RSS: Main: 226996224 13:21:52 INFO - PROCESS | 15550 | 13:21:56 INFO - PROCESS | 15550 | Cycle 1(1): loaded http://localhost:48285/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48285/tests/kraken/driver.html?testName=imaging-desaturate) 13:21:56 INFO - PROCESS | 15550 | RSS: Main: 226131968 13:21:56 INFO - PROCESS | 15550 | 13:21:59 INFO - PROCESS | 15550 | Cycle 1(1): loaded http://localhost:48285/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48285/tests/kraken/driver.html?testName=json-parse-financial) 13:22:00 INFO - PROCESS | 15550 | RSS: Main: 226119680 13:22:00 INFO - PROCESS | 15550 | 13:22:01 INFO - PROCESS | 15550 | Cycle 1(1): loaded http://localhost:48285/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48285/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:22:02 INFO - PROCESS | 15550 | RSS: Main: 187887616 13:22:02 INFO - PROCESS | 15550 | 13:22:04 INFO - PROCESS | 15550 | Cycle 1(1): loaded http://localhost:48285/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48285/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:22:04 INFO - PROCESS | 15550 | RSS: Main: 195477504 13:22:04 INFO - PROCESS | 15550 | 13:22:06 INFO - PROCESS | 15550 | Cycle 1(1): loaded http://localhost:48285/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48285/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:22:07 INFO - PROCESS | 15550 | RSS: Main: 193191936 13:22:07 INFO - PROCESS | 15550 | 13:22:09 INFO - PROCESS | 15550 | Cycle 1(1): loaded http://localhost:48285/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48285/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:22:10 INFO - PROCESS | 15550 | RSS: Main: 187363328 13:22:10 INFO - PROCESS | 15550 | 13:22:13 INFO - PROCESS | 15550 | Cycle 1(1): loaded http://localhost:48285/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48285/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:22:13 INFO - PROCESS | 15550 | RSS: Main: 191815680 13:22:13 INFO - PROCESS | 15550 | 13:22:15 INFO - PROCESS | 15550 | Cycle 1(1): loaded http://localhost:48285/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48285/tests/kraken/driver.html?testName=ai-astar) 13:22:15 INFO - PROCESS | 15550 | RSS: Main: 242630656 13:22:15 INFO - PROCESS | 15550 | 13:22:15 INFO - PROCESS | 15550 | __start_tp_report 13:22:15 INFO - PROCESS | 15550 | _x_x_mozilla_page_load 13:22:15 INFO - PROCESS | 15550 | _x_x_mozilla_page_load_details 13:22:15 INFO - PROCESS | 15550 | |i|pagename|runs| 13:22:15 INFO - PROCESS | 15550 | |0;ai-astar;101;111;111;111;109;111;111;111;110;110 13:22:15 INFO - PROCESS | 15550 | |1;audio-beat-detection;143;116;118;185;117;119;141;120;158;120 13:22:15 INFO - PROCESS | 15550 | |2;audio-dft;161;160;160;162;160;160;160;159;161;161 13:22:15 INFO - PROCESS | 15550 | |3;audio-fft;75;74;76;115;75;75;76;74;99;76 13:22:15 INFO - PROCESS | 15550 | |4;audio-oscillator;85;85;138;86;84;85;125;85;84;128 13:22:15 INFO - PROCESS | 15550 | |5;imaging-gaussian-blur;117;117;117;117;116;117;117;117;117;116 13:22:15 INFO - PROCESS | 15550 | |6;imaging-darkroom;146;146;146;145;146;146;146;146;146;145 13:22:15 INFO - PROCESS | 15550 | |7;imaging-desaturate;95;94;95;95;95;95;95;95;95;96 13:22:15 INFO - PROCESS | 15550 | |8;json-parse-financial;52;54;57;54;50;64;51;57;53;50 13:22:15 INFO - PROCESS | 15550 | |9;json-stringify-tinderbox;62;63;61;62;62;62;62;61;62;62 13:22:15 INFO - PROCESS | 15550 | |10;stanford-crypto-aes;79;78;78;78;86;77;78;87;84;81 13:22:15 INFO - PROCESS | 15550 | |11;stanford-crypto-ccm;125;124;126;122;132;121;123;123;140;125 13:22:15 INFO - PROCESS | 15550 | |12;stanford-crypto-pbkdf2;162;167;159;163;158;159;163;163;165;163 13:22:15 INFO - PROCESS | 15550 | |13;stanford-crypto-sha256-iterative;67;62;64;62;63;63;64;64;61;63 13:22:15 INFO - PROCESS | 15550 | __end_tp_report 13:22:15 INFO - PROCESS | 15550 | __start_cc_report 13:22:15 INFO - PROCESS | 15550 | _x_x_mozilla_cycle_collect,1679 13:22:15 INFO - PROCESS | 15550 | __end_cc_report 13:22:15 INFO - PROCESS | 15550 | __startTimestamp1471551735826__endTimestamp 13:22:15 INFO - PROCESS | 15550 | 13:22:15 INFO - PROCESS | 15550 | ------- Summary: start ------- 13:22:15 INFO - PROCESS | 15550 | Number of tests: 14 13:22:15 INFO - PROCESS | 15550 | 13:22:15 INFO - PROCESS | 15550 | [#0] ai-astar Cycles:10 Average:109.60 Median:111.00 stddev:3.10 (2.8%) stddev-sans-first:0.73 13:22:15 INFO - PROCESS | 15550 | Values: 101.0 111.0 111.0 111.0 109.0 111.0 111.0 111.0 110.0 110.0 13:22:15 INFO - PROCESS | 15550 | 13:22:15 INFO - PROCESS | 15550 | [#1] audio-beat-detection Cycles:10 Average:133.70 Median:130.50 stddev:23.07 (17.7%) stddev-sans-first:24.23 13:22:15 INFO - PROCESS | 15550 | Values: 143.0 116.0 118.0 185.0 117.0 119.0 141.0 120.0 158.0 120.0 13:22:15 INFO - PROCESS | 15550 | 13:22:15 INFO - PROCESS | 15550 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.50 stddev:0.84 (0.5%) stddev-sans-first:0.87 13:22:15 INFO - PROCESS | 15550 | Values: 161.0 160.0 160.0 162.0 160.0 160.0 160.0 159.0 161.0 161.0 13:22:15 INFO - PROCESS | 15550 | 13:22:15 INFO - PROCESS | 15550 | [#3] audio-fft Cycles:10 Average:81.50 Median:75.50 stddev:13.98 (18.5%) stddev-sans-first:14.63 13:22:15 INFO - PROCESS | 15550 | Values: 75.0 74.0 76.0 115.0 75.0 75.0 76.0 74.0 99.0 76.0 13:22:15 INFO - PROCESS | 15550 | 13:22:15 INFO - PROCESS | 15550 | [#4] audio-oscillator Cycles:10 Average:98.50 Median:85.00 stddev:22.21 (26.1%) stddev-sans-first:23.01 13:22:15 INFO - PROCESS | 15550 | Values: 85.0 85.0 138.0 86.0 84.0 85.0 125.0 85.0 84.0 128.0 13:22:15 INFO - PROCESS | 15550 | 13:22:15 INFO - PROCESS | 15550 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 13:22:15 INFO - PROCESS | 15550 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 13:22:15 INFO - PROCESS | 15550 | 13:22:15 INFO - PROCESS | 15550 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 13:22:15 INFO - PROCESS | 15550 | Values: 146.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 145.0 13:22:15 INFO - PROCESS | 15550 | 13:22:15 INFO - PROCESS | 15550 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 13:22:15 INFO - PROCESS | 15550 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 13:22:15 INFO - PROCESS | 15550 | 13:22:15 INFO - PROCESS | 15550 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.00 stddev:4.26 (7.9%) stddev-sans-first:4.45 13:22:15 INFO - PROCESS | 15550 | Values: 52.0 54.0 57.0 54.0 50.0 64.0 51.0 57.0 53.0 50.0 13:22:15 INFO - PROCESS | 15550 | 13:22:15 INFO - PROCESS | 15550 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:62.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 13:22:15 INFO - PROCESS | 15550 | Values: 62.0 63.0 61.0 62.0 62.0 62.0 62.0 61.0 62.0 62.0 13:22:15 INFO - PROCESS | 15550 | 13:22:15 INFO - PROCESS | 15550 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:80.00 stddev:3.72 (4.6%) stddev-sans-first:3.90 13:22:15 INFO - PROCESS | 15550 | Values: 79.0 78.0 78.0 78.0 86.0 77.0 78.0 87.0 84.0 81.0 13:22:15 INFO - PROCESS | 15550 | 13:22:15 INFO - PROCESS | 15550 | [#11] stanford-crypto-ccm Cycles:10 Average:126.10 Median:125.00 stddev:5.74 (4.6%) stddev-sans-first:6.08 13:22:15 INFO - PROCESS | 15550 | Values: 125.0 124.0 126.0 122.0 132.0 121.0 123.0 123.0 140.0 125.0 13:22:15 INFO - PROCESS | 15550 | 13:22:15 INFO - PROCESS | 15550 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.20 Median:163.00 stddev:2.82 (1.7%) stddev-sans-first:2.99 13:22:15 INFO - PROCESS | 15550 | Values: 162.0 167.0 159.0 163.0 158.0 159.0 163.0 163.0 165.0 163.0 13:22:15 INFO - PROCESS | 15550 | 13:22:15 INFO - PROCESS | 15550 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:63.50 stddev:1.64 (2.6%) stddev-sans-first:1.05 13:22:15 INFO - PROCESS | 15550 | Values: 67.0 62.0 64.0 62.0 63.0 63.0 64.0 64.0 61.0 63.0 13:22:15 INFO - PROCESS | 15550 | -------- Summary: end -------- 13:22:15 INFO - PROCESS | 15550 | 13:22:16 INFO - TEST-INFO | 15550: exit 0 13:22:16 INFO - TEST-OK | kraken | took 60885ms 13:22:16 INFO - SUITE-END | took 1176s 13:22:16 INFO - Completed test suite (00:19:36) 13:22:16 INFO - javascript benchmark 13:22:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2987.0590763909368, 3033.1658793831693, 3036.3471853551487, 3044.0411270449795, 3049.5120780675097, 5192.896142077157, 5216.165413533835, 5298.205269209616, 5394.433584473632, 5416.620836541439, 5191.5327620514145, 5255.500727430888, 5263.657862238952, 5284.577233821295, 5352.170413585901, 4660.091282199973, 4759.048190361924, 4761.142994261032, 4766.73782941938, 4920.237363208708, 4844.709317440947, 4873.951260487385, 4890.682105663121, 4892.9510704892855, 4900.240462728283, 4676.392069031038, 4695.413073365829, 4708.717476951377, 4716.9292460613115, 4837.661363704542, 4793.712377257376, 4794.616430685572, 4798.232282834764, 4806.966502202008, 4916.287138364953, 4813.903721925577, 4838.201696720037, 4839.104765618372, 4855.46589875117, 4871.658983871131, 5216.452272511369, 5271.209318602202, 5285.418603953562, 5286.392064912546, 5358.303420555342, 5661.716914154275, 5677.545796336283, 5679.204911312419, 5701.486866182022, 5710.400407957146, 5657.434256574351, 5693.28833895763, 5722.399148089474, 5763.452472015152, 5765.308163020464, 5137.61467889906, 5185.507376799198, 5283.630145889828, 5290.259363689087, 5375.704336261543, 5845.1232315153065, 5859.238299021185, 5865.178874957509, 5866.325372582208, 5868.061110222344, 5595.21666966625, 5625.353084395265, 5651.095824668033, 5653.575981801299, 5656.745446454919, 5514.228008078872, 5547.057000309957, 5576.693281869536, 5578.97210513953, 5673.1490276458035, 5590.133529302883, 5593.8321850344555, 5594.692291923902, 5596.3284405870745, 5623.0, 5556.249906262603, 5590.8043218487155, 5601.887962240732, 5606.243157173811, 5606.719664016783, 4222.0, 4309.353596960418, 4309.84915527955, 4367.58507941745, 4367.890802729894, 3907.0427745202605, 3930.567637559866, 3932.508436445444, 3933.3116704576582, 3933.6853051755793, 5252.737363131828, 5304.363476382859, 5317.840464785985, 5355.437679043722, 5399.433059528771, 5632.211490391349, 5639.154126881001, 5653.180288858175, 5661.377248502661, 5673.120666296731, 5164.535191832678, 5235.633505654644, 5297.682139071668, 5306.151015837448, 5310.336207974004, 4840.298156767249, 4854.5873600744335, 4858.05267972749, 4881.804727810848, 4888.413390393175, 5815.244018277597, 5831.504322132581, 5840.977828879929, 5846.298444186725, 5846.444587764156, 5456.781728730965, 5596.076647353304, 5651.971740141273, 5656.123300888369, 5659.490645841894, 5736.110902810071, 5821.970890145522, 5837.270341207349, 5885.705714714333, 5952.910706339322, 5592.412796656456, 5596.86007849807, 5601.04782187021, 5604.3835178131185, 5608.551315894637, 5539.806106786243, 5709.400512946081, 5726.599138060463, 5730.025895597675, 5736.971315143398, 5437.8368648940595, 5518.061929471919, 5543.085390910454, 5588.13383925476, 5631.971840140773, 5439.646422982493, 5480.616356854982, 5483.917741233805, 5484.61607687458, 5496.642718223303, 5272.78908843642, 5421.810236641699, 5430.592705547178, 5432.239486471976, 5474.275603184984, 5550.084236100998, 5595.328560572757, 5637.88724225505, 5639.013172694844, 5643.097104463266, 5459.153831156177, 5481.232627432083, 5481.506664400223, 5482.150266708666, 5482.725863706719], "value": 5211.143476312739, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.1807532717838, 607.3653032580954, 618.3538202578305, 624.5596854217777, 645.6190847400034, 42756.78621606892, 43896.78051609745, 43920.12159756811, 44231.55768442315, 47859.28211076836, 45519.0, 46001.539984600226, 46003.53996460034, 46033.53966460334, 46050.539494605044, 8873.201411872946, 8967.551622418885, 8971.46171229725, 9012.053734357896, 9017.954910225473, 8877.422967507124, 8965.417247878899, 8969.95515022424, 8972.820543589158, 8978.50618215998, 9005.594748236344, 9073.682421115262, 9078.77303067422, 9083.046280140588, 9084.682036128737, 8979.865302020442, 9004.819903601956, 9020.77448063797, 9021.684241051564, 9024.684136055206, 8935.64257429702, 9005.369624126313, 9007.729768106967, 9008.77478063047, 9009.684661036832, 43716.562834371565, 44030.33954490685, 44076.016579253686, 44178.33732494015, 44209.0, 3500.8035776675397, 3632.9636703633155, 3753.11801726594, 4040.434339192486, 4325.740455572644, 31863.0, 32272.6772732272, 33171.50242746361, 33223.66776332254, 33393.0, 4341.913161736779, 4450.443694538183, 4452.421185245929, 4648.604868586174, 4650.465196502378, 348207.0, 349505.0, 349911.0, 350863.0, 351046.24476877705, 58470.0, 58954.70522647359, 59185.70407148023, 59266.0, 59365.70317148387, 61636.0, 61753.691231543555, 61860.38139618636, 61878.0, 61894.0484761218, 16571.0, 16812.915935420246, 16829.242684079247, 16842.915785420995, 16844.07357595344, 12982.221066736027, 13031.804522932163, 13062.281574513492, 13075.280859552817, 13075.738485230242, 15856.60358491047, 16484.42304519336, 16484.42304519336, 16714.331426742796, 16831.41090061842, 6501.642409667514, 6568.67156642166, 6671.132752742113, 6719.798406047827, 6761.864762704817, 952.8856537215579, 1020.2501161646184, 1047.2145890582065, 1112.5994641928899, 1134.6709454258337, 33321.0, 33890.32219355649, 33905.49141762876, 33930.49104263438, 34461.0, 1103.489264753232, 1137.1641843245209, 1160.3675996581883, 1172.3317708906013, 1254.5489846616438, 17678.348247762682, 17679.0, 17694.91152544229, 17728.202230899642, 17779.73330400045, 517911.0, 518654.40672796394, 518832.0, 520086.0, 520137.0, 60089.39910600838, 60354.0, 60566.394336056954, 60707.0, 60735.69632151899, 1244.6577191272293, 1336.3652265173964, 1384.4323827230787, 1389.083205084619, 1412.6044707481922, 31749.0, 34815.0, 35058.298834023684, 35082.64917350794, 35149.47275790814, 51284.48715512797, 52024.0, 52151.73924130355, 52170.739146304026, 52186.73906630594, 305364.0, 305960.0, 306143.0, 307283.0, 307441.0, 41899.162016758884, 42589.0, 42977.0, 43213.78393108014, 43453.0, 49112.263316049575, 49574.256386153516, 50125.74937125291, 50276.737546811215, 50691.74654126706, 39154.6084539151, 40781.79609101936, 41450.0, 43626.56373436225, 43875.0, 41968.16063678648, 42033.36949945692, 42090.368644469745, 43375.34936976011, 43792.562074378846, 42831.1433771329, 42862.0, 44373.11253774842, 44542.331865021406, 44546.3318050223, 35263.471047934814, 38135.80932095433, 38455.61544384521, 38518.614813851505, 39042.609573903894, 29194.7080529192, 29398.265043374086, 29519.55720664235, 29556.391721952838, 29752.256193595334], "value": 20555.286694298793, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.10389377176097, 392.60543154130096, 405.78696184503144, 408.51590864825187, 425.0245686150285, 13970.580882573513, 18461.0, 19254.0, 19668.508287292825, 19732.210711571537, 12952.80570791439, 13088.93455532721, 13140.14589051711, 13236.404361803718, 13239.867601323984, 3942.3889297158985, 5048.066107770056, 5174.068667639824, 5176.352955880515, 5177.145770947808, 5632.5212356949505, 5854.76580936762, 5902.763889444417, 5979.551533634973, 5985.730642121115, 5940.287165540141, 5978.910316345258, 5993.580449368546, 6470.967645161768, 6527.379898909596, 6342.968285158568, 6446.452051575622, 6472.255690595594, 6472.35276472349, 6486.740530378779, 5591.3569939456665, 5724.656520608735, 5773.336066352381, 5774.700692344231, 5778.566607504454, 14578.12531248118, 14694.55916322512, 17952.551186220448, 23346.416339591477, 23627.0, 2246.4271610739156, 2325.9651105233434, 2445.9510809783706, 2586.301698541402, 2822.8849604406146, 10771.0, 11017.724556886062, 11030.28303160292, 11593.710157246052, 14120.71758564823, 1952.9609407811906, 2024.5039965208618, 2028.4523178741804, 2029.6752519596942, 2035.0740413111998, 74903.0, 81715.0, 81836.59081704554, 83207.5839620804, 83690.0, 10907.945460272647, 11010.229283950206, 11191.019996101657, 11286.0, 11484.540618375338, 15392.0, 15433.922830386, 15436.305366258546, 15437.459688911058, 15446.459373921858, 7483.8877416838795, 7559.3196612304055, 7800.414968877357, 7807.765767026998, 7870.645820938072, 7182.174049984214, 7190.568565886064, 7194.244604316471, 7415.1472580652835, 7431.2197219292275, 4699.459562150328, 4739.102532457957, 4822.9758851206225, 4918.11473934688, 4996.7501624918605, 1945.6497830390383, 1985.4043786864172, 2041.530447996969, 2041.7243672104075, 2068.586282743427, 960.3722187978441, 964.9710508684751, 974.8830140383058, 978.1392374710209, 996.4619105682995, 19577.608447830964, 19901.60196796056, 19971.301004464774, 20102.49743756418, 20144.49638759043, 954.4559601027487, 969.5927710361665, 978.7210644966293, 1015.9796804063877, 1024.5082360467018, 10436.37381757097, 10442.796000039776, 10986.670399888017, 10999.335956470448, 11015.669529914116, 471410.0, 472865.0, 477416.0, 479134.0, 479205.0, 59157.70421147867, 61920.0, 92369.0, 96132.0, 97139.0, 928.1414691410554, 928.5403725156091, 953.5232383808096, 954.117441366733, 972.1105188752213, 16812.747808783122, 17028.744568831724, 17771.378001769877, 17881.821181788535, 17963.820361796737, 41759.164816704106, 41812.58187418087, 42084.57915420806, 42402.15195696007, 42621.78689106535, 52274.477255228485, 55681.72159139178, 56551.15173272322, 56600.716996414754, 57076.59395805446, 5535.944640553704, 8363.375624912744, 8423.70517031901, 8464.518709225738, 8829.293656507592, 11030.448477575928, 12017.0, 12398.25610463375, 12710.173838700455, 12853.421596028014, 11132.944335278271, 11334.206605537533, 11636.185467017227, 11690.240134391237, 11709.590164344207, 11001.504932277907, 11014.39420831862, 11054.281471704313, 11303.491342889754, 11765.823512647488, 11225.49485273181, 11451.885481145082, 11511.136664750009, 11558.711032224262, 11615.186936914335, 7661.885071723817, 7801.102873169658, 8398.622062007347, 8402.621882015446, 8704.825903481767, 11562.364069976233, 11583.478743456397, 11745.647630571097, 11774.175807693722, 12374.690632734253], "value": 9006.959224926604, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1324.8277723895892, 1469.816272965879, 1473.0866862545224, 1614.677064587083, 1758.621896292296, 8282.461639993397, 8637.91362086379, 8715.302775777938, 8912.821743565124, 8994.955025224865, 8750.6937257196, 8857.42426742263, 8861.291096712264, 8862.64549418024, 8866.911330886705, 2016.9899150504227, 2303.34354708908, 2352.529494101178, 2385.5586716457424, 2386.95226095478, 2388.7969522590515, 2406.9398265043337, 2411.7829395354415, 2415.927522174338, 2419.346776370379, 2329.0, 2336.6144586143264, 2348.518553696488, 2354.7174339079334, 2369.3365857559825, 2244.136007637055, 2297.7242730872317, 2310.6880571122933, 2310.838241323108, 2331.5103828196097, 2373.7626237376126, 2391.210900402863, 2392.1986134644917, 2397.208921056065, 2397.7602239776056, 8865.955670221607, 8917.331200160013, 8922.464652120894, 8924.732258032269, 8930.151635594608, 5251.55361794248, 5301.655392399482, 5443.537299329561, 5446.046941785172, 5449.964506743706, 3311.850966706504, 3421.8289085545625, 3454.360943225511, 3497.3704733148024, 3500.824958752052, 1059.7071572681316, 1113.6269349767838, 1152.6426807689643, 1163.8661553921238, 1169.6549517892242, 12467.438965246585, 12521.56174533896, 12552.74050670879, 12583.937080314632, 12588.496460141583, 4410.1400226956075, 4583.862484125481, 4752.477227504972, 4760.071786001766, 4776.164171270014, 9772.706818795305, 9787.314887957775, 9790.06994335537, 9793.069658382443, 9814.116729494237, 5398.325209348832, 5408.432114627986, 5409.161579955114, 5411.269478620336, 5413.188021796762, 4396.780160991938, 4830.782614782343, 4969.975150124298, 5036.0, 5055.747212639353, 3651.580068292127, 3782.6973842093116, 3796.088938654703, 3813.103920578662, 3869.6710779583486, 1104.8508451359126, 1154.417019405195, 1157.9231314877245, 1166.8249762535518, 1182.8876256755595, 883.4522595990527, 945.8439357505935, 958.152035448633, 965.710286913923, 1000.4497526360473, 5948.762049518057, 6156.8768624627255, 6193.256809182837, 6363.809085727436, 6386.042093685985, 464.7745843266013, 488.5822621658431, 491.8327768558636, 1031.5203430404897, 1140.372794962767, 3915.804209789556, 4088.5707000765087, 4108.1783643271465, 4203.117345357448, 4322.24360736876, 10789.676309710721, 10985.61550345734, 11089.944550277358, 11101.111911047097, 11118.666440006813, 10978.396188209725, 10981.725456863642, 10992.0, 11026.228164028602, 11048.944755276172, 8153.510789352657, 8238.588070596446, 8266.545340006238, 8269.09040005599, 8282.917170828214, 6090.9390906090375, 6116.532032312124, 6184.072389141665, 6224.066390041349, 6283.434490895841, 10099.091081802673, 10117.392956422638, 10127.291089623655, 10173.08442240202, 10237.692869213935, 10181.796364072825, 10409.137487191083, 10482.895171048192, 10568.788624227625, 10584.4707764613, 7239.819004524718, 7658.540487570764, 7821.061472623322, 8057.879131813144, 8267.669293228204, 8419.158084191777, 8722.433041852513, 8725.3892227546, 8727.127287271222, 8731.869021964803, 7594.31651151399, 7626.161122276434, 7732.9226707732205, 7862.371010319275, 7969.6015199238645, 7451.813704657427, 7597.240275972579, 7648.923510764821, 7684.807879802826, 7749.845003099794, 6882.621455819978, 6968.0, 6988.510804243654, 6990.965045174741, 6996.335348141918, 5279.788808447619, 5308.416074231909, 5346.518813306821, 5361.4370491099435, 5614.719264036864, 5381.354237491526, 5408.891822163613, 5493.368262649847, 5537.141743029837, 5562.3313006098815], "value": 4638.136521710167, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.10411950657664, 330.24868424334636, 332.49294825391274, 344.60370573840083, 345.6077352205246, 5243.8689032774155, 5267.683938963655, 5268.31511903453, 5286.867828304289, 5298.549623282026, 4950.356453661028, 4982.0, 5066.873328166797, 5102.438731739506, 5220.530152286294, 4047.9797601011956, 4095.5051406236657, 4109.486314210723, 4130.8141133648905, 4131.876043718693, 4108.938365924513, 4119.917601647965, 4125.484314460692, 4128.772917489537, 4144.689148313873, 3871.8644847430346, 3874.786886721229, 4046.372812214097, 4062.106336605942, 4075.286824805662, 4013.5585085640555, 4046.309204379114, 4049.129437170993, 4058.269511487916, 4065.8373665053364, 3619.7828130312, 3629.745917785756, 3634.127809325743, 3646.690031347339, 3652.5982141964364, 4786.904261914742, 5099.235114732783, 5116.923246151311, 5127.077126117298, 5183.248428977777, 4670.252759558454, 4681.133990211822, 4683.1336202802595, 4683.431050598054, 4746.935083238802, 5392.548768787979, 5413.188021796762, 5425.294711687495, 5468.835934921919, 5483.588730845203, 3813.80930953454, 3997.8600748973645, 4078.7348822326453, 4079.3269110596716, 4086.836526538935, 5616.52259557938, 5635.830925072254, 5643.238162848045, 5656.575756818255, 5660.433956604306, 4086.346184610448, 4095.447114639545, 4106.938395924063, 4118.464599602033, 4135.152293779768, 3987.0, 4173.624373806311, 4178.143480586473, 4179.0, 4190.664746820247, 4664.160451118832, 4664.183767840615, 4669.136209801198, 4703.17694403478, 4716.622670186377, 5431.103867861759, 5438.8912221755345, 5449.536789372948, 5488.945110548843, 5517.917231241535, 1335.30564106664, 1434.8278206615273, 1446.8191476065492, 1451.3396404635864, 1458.6790906000663, 916.9128932751378, 955.8375076237056, 972.8929817720045, 975.6146322202691, 977.1742877268697, 4450.955490445119, 4649.349091127245, 4652.232381656989, 4686.5782079613, 4694.882627934329, 4916.418880087911, 4943.184374578154, 4944.60443164546, 4950.727709975914, 4952.504749525018, 4617.746023968714, 4663.300504924221, 4679.789409476582, 4689.20283551797, 4698.580231180945, 2514.5976643736913, 2620.174644986823, 2637.709851916288, 2646.2193652872447, 2649.205238428502, 5028.874278143003, 5038.949610503848, 5061.392632884077, 5066.620003499752, 5083.297095473058, 5040.4455509894615, 5047.369078865142, 5064.898702025939, 5095.210242412432, 5123.564497017721, 5097.903950650554, 5113.593761715483, 5130.948690513122, 5371.462853714597, 5803.0, 5649.915251271316, 5651.88696226065, 5654.06707893193, 5654.293213348332, 5666.829995100154, 5575.888482230252, 5599.076152434803, 5599.188117722989, 5617.578681598815, 5639.520640745583, 5596.188552659923, 5726.427357264407, 5757.539396848326, 5771.239771869452, 5778.768849245983, 3987.6610488108836, 4009.8195581198333, 4030.0, 4033.757974521538, 4052.682878064582, 5388.568914486753, 5492.407201911401, 5531.446855314436, 5582.665040097607, 5645.71771411436, 5405.72971351423, 5431.646942948696, 5437.13005919051, 5437.483439073281, 5441.238226648194, 5258.184981327748, 5426.07756681373, 5442.496451632293, 5455.509004189642, 5475.67145971243, 5383.757730902197, 5387.622866399314, 5419.160030195326, 5421.403645598902, 5425.647332923348, 5484.232207490874, 5520.0, 5524.111161621913, 5524.364698059614, 5530.1197592818635, 5198.922016169685, 5313.203019546944, 5365.892682146413, 5401.3248343957, 5406.5945054121885], "value": 4096.3454290870795, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [769.8743103001813, 794.638439510023, 822.7038266224162, 831.2103501673408, 843.7131375332385, 14985.0, 16146.515604531853, 16161.595960101004, 16196.919015404907, 16318.265678044487, 14567.635809104777, 14753.0, 14993.0, 15006.774898376505, 15015.624609384771, 794.1264608930173, 799.0890384961149, 807.1484583764127, 807.3581502705334, 807.8990126234221, 644.4940721533598, 759.3014426727397, 800.6397121295412, 805.3074356053789, 805.5448671500612, 862.2886118951858, 876.8684697295425, 876.9868451973225, 877.0133599700337, 877.2587163846539, 872.0233338660709, 872.145297608341, 872.4416373520984, 872.4852337121097, 872.7861673889875, 494.69081823860085, 585.6983653418492, 633.5375176121411, 633.7053270229366, 633.7179954920063, 15212.543623691196, 15486.22568871552, 15514.456994005268, 15519.612009699847, 15524.534263972098, 13918.0, 14096.644509015565, 14562.563123106323, 14761.33573989173, 14822.925885370503, 13163.0, 13250.933745331307, 13409.717590610815, 13666.385012674453, 13849.307534623229, 4489.0023939347, 4556.954430455686, 4565.452145742533, 4737.905241895177, 4765.26138448541, 79925.60037199777, 80323.19676803274, 81432.59283703544, 82796.75804862993, 83617.0, 11425.828612570818, 11425.942870285762, 11474.196806223485, 11684.0, 12217.083718720954, 22137.557248855253, 22149.224777133044, 22197.55604887893, 22212.0, 22243.555128897657, 7981.48120372174, 8242.835143297101, 8348.33213342931, 8548.358873084544, 8787.12128787129, 4773.546513081252, 4817.638677099231, 4848.515148485123, 4947.35684361038, 5097.515736005073, 3451.9827400862837, 3831.1762970961377, 4058.411530328086, 4059.5331536873045, 4063.6545893599377, 742.3133601418666, 754.7169811320755, 755.1466842467976, 759.400073941591, 759.9620018999028, 570.8258981010748, 614.5636598015459, 648.5298158834808, 753.7173559915032, 792.8335049639641, 9937.701868943943, 10254.794904101876, 10494.68515944523, 10620.734481638021, 10674.839877401846, 704.7568588836843, 706.3254591864757, 718.2007182007228, 718.5939943931662, 731.1226528166222, 4996.931796071646, 5219.347581552306, 5231.267622532849, 5262.184361423985, 5286.788528458818, 103661.0, 126303.0, 127399.0, 131062.0, 131456.0, 107473.24913662582, 109499.0, 110697.0, 112866.43566782278, 114967.42516287365, 56881.431185687616, 59349.70325148433, 75968.62015689886, 92548.0, 95855.0, 9825.459599722084, 10295.433751143759, 10436.269461137648, 10478.738031549272, 10642.62750803749, 51659.0, 52649.736751317534, 53356.1996570044, 53569.0, 54435.0, 67388.0, 72939.63530182315, 73101.26898730945, 73373.633131834, 77709.0, 13556.59330220095, 13770.793438098237, 13905.582832515041, 14155.962756348128, 14198.219097949712, 15287.61780955485, 15483.612909677347, 15511.5346539604, 15954.202289885692, 15978.360865565248, 14512.927435362755, 14818.481353152589, 14884.181370024753, 14992.400303987719, 15084.924575377054, 14418.062825916282, 14657.48698795537, 14827.258637068318, 14901.776473353126, 15657.530274091796, 14585.92707036458, 14848.951356538828, 15571.221438928234, 15614.765778513558, 15667.608309792346, 11754.76490470203, 11844.585439509576, 12271.57049503263, 12362.876371236172, 12439.253644781342, 10045.49772511357, 11434.313941163557, 12546.247225166519, 12638.494460221857, 12651.597446466396], "value": 7916.481774806204, "unit": "score"}], "name": "dromaeo_css", "value": 7249.239851278607, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 111.0, 111.0, 109.0, 111.0, 111.0, 111.0, 110.0, 110.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 116.0, 118.0, 185.0, 117.0, 119.0, 141.0, 120.0, 158.0, 120.0], "value": 133.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 162.0, 160.0, 160.0, 160.0, 159.0, 161.0, 161.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 115.0, 75.0, 75.0, 76.0, 74.0, 99.0, 76.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 138.0, 86.0, 84.0, 85.0, 125.0, 85.0, 84.0, 128.0], "value": 98.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 54.0, 57.0, 54.0, 50.0, 64.0, 51.0, 57.0, 53.0, 50.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 61.0, 62.0, 62.0, 62.0, 62.0, 61.0, 62.0, 62.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 78.0, 78.0, 86.0, 77.0, 78.0, 87.0, 84.0, 81.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 124.0, 126.0, 122.0, 132.0, 121.0, 123.0, 123.0, 140.0, 125.0], "value": 126.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 167.0, 159.0, 163.0, 158.0, 159.0, 163.0, 163.0, 165.0, 163.0], "value": 162.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 62.0, 64.0, 62.0, 63.0, 63.0, 64.0, 64.0, 61.0, 63.0], "value": 63.3, "unit": "score"}], "name": "kraken", "value": 1489.6, "alertThreshold": 2.0}]} 13:22:17 INFO - Return code: 0 13:22:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:22:17 INFO - # TBPL SUCCESS # 13:22:17 INFO - Running post-action listener: _resource_record_post_action 13:22:17 INFO - [mozharness: 2016-08-18 20:22:17.114827Z] Finished run-tests step (success) 13:22:17 INFO - Running post-run listener: _resource_record_post_run 13:22:17 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 416141312; Read time: 20; Write time: 374232 13:22:17 INFO - TinderboxPrint: CPU usage
13.0% 13:22:17 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 13:22:17 INFO - TinderboxPrint: I/O write bytes / time
416,141,312 / 374,232 13:22:17 INFO - TinderboxPrint: CPU idle
8,284.9 (86.9%) 13:22:17 INFO - TinderboxPrint: CPU user
1,198.0 (12.6%) 13:22:17 INFO - TinderboxPrint: Swap in / out
0 / 0 13:22:17 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 125665280; Read time: 0; Write time: 103336 13:22:17 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 289951744; Read time: 0; Write time: 270864 13:22:17 INFO - Running post-run listener: _upload_blobber_files 13:22:17 INFO - Blob upload gear active. 13:22:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:22:17 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 13:22:17 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'] 13:22:17 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 13:22:18 INFO - (blobuploader) - INFO - Open directory for files ... 13:22:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:22:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:22:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:22:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:22:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:22:19 INFO - (blobuploader) - INFO - Done attempting. 13:22:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:22:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:22:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:22:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:22:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:22:19 INFO - (blobuploader) - INFO - Done attempting. 13:22:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:22:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:22:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:22:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:22:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:22:23 INFO - (blobuploader) - INFO - Done attempting. 13:22:23 INFO - (blobuploader) - INFO - Iteration through files over. 13:22:23 INFO - Return code: 0 13:22:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:22:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:22:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e3e5d130f5ec4e6687d4d67918b8b1a9b72d3478ad6c33bc13c99685ab37487db246d2416157069945fd4c64799d8a7b25fbe9f47a88c9ea275119869b853b8f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/60bc3b35c1acc0ef4da5988fbec34907adf3d53b77ec16d4b1d30531feeddb3ef8539bff87c72f03d4168b7818cee97261e347b7c678a841bde595f74aa2f065", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/96dd8a1737716d69af11fb9ffc4a567ef4d2adc468c21529b8b705137031d1db9de65da61e71eb51d3729ea0999b2eccec34ee665f2a669deccc9ac6ee3a36e5"} 13:22:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:22:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:22:23 INFO - Contents: 13:22:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e3e5d130f5ec4e6687d4d67918b8b1a9b72d3478ad6c33bc13c99685ab37487db246d2416157069945fd4c64799d8a7b25fbe9f47a88c9ea275119869b853b8f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/60bc3b35c1acc0ef4da5988fbec34907adf3d53b77ec16d4b1d30531feeddb3ef8539bff87c72f03d4168b7818cee97261e347b7c678a841bde595f74aa2f065", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/96dd8a1737716d69af11fb9ffc4a567ef4d2adc468c21529b8b705137031d1db9de65da61e71eb51d3729ea0999b2eccec34ee665f2a669deccc9ac6ee3a36e5"} 13:22:23 INFO - Running post-run listener: copy_logs_to_upload_dir 13:22:23 INFO - Copying logs to upload dir... 13:22:23 INFO - mkdir: /builds/slave/test/build/upload/logs 13:22:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.192347 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-08-18 13:22:23.914351) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-18 13:22:23.917530) ========= 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=7de08804244eb36560b44971000001c3-1471550502.828633-1541337525 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/e3e5d130f5ec4e6687d4d67918b8b1a9b72d3478ad6c33bc13c99685ab37487db246d2416157069945fd4c64799d8a7b25fbe9f47a88c9ea275119869b853b8f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/60bc3b35c1acc0ef4da5988fbec34907adf3d53b77ec16d4b1d30531feeddb3ef8539bff87c72f03d4168b7818cee97261e347b7c678a841bde595f74aa2f065", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/96dd8a1737716d69af11fb9ffc4a567ef4d2adc468c21529b8b705137031d1db9de65da61e71eb51d3729ea0999b2eccec34ee665f2a669deccc9ac6ee3a36e5"} build_url:https://queue.taskcluster.net/v1/task/ZjA3gEcrR_-l_pMB417TSg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011154 build_url: 'https://queue.taskcluster.net/v1/task/ZjA3gEcrR_-l_pMB417TSg/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/e3e5d130f5ec4e6687d4d67918b8b1a9b72d3478ad6c33bc13c99685ab37487db246d2416157069945fd4c64799d8a7b25fbe9f47a88c9ea275119869b853b8f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/60bc3b35c1acc0ef4da5988fbec34907adf3d53b77ec16d4b1d30531feeddb3ef8539bff87c72f03d4168b7818cee97261e347b7c678a841bde595f74aa2f065", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/96dd8a1737716d69af11fb9ffc4a567ef4d2adc468c21529b8b705137031d1db9de65da61e71eb51d3729ea0999b2eccec34ee665f2a669deccc9ac6ee3a36e5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-18 13:22:23.943052) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 13:22:23.943429) ========= 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=7de08804244eb36560b44971000001c3-1471550502.828633-1541337525 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004437 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 13:22:24.029928) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-18 13:22:24.030398) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-18 13:22:24.030744) ========= ========= Total master_lag: 0.19 =========