builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-052 starttime: 1472781531.48 results: success (0) buildid: 20160901175543 builduid: 2026aa1659c846dbbd3626fdd61c7bee revision: 4f8bafdd88dc6cfdb5b5fe074dfb5d1abdb2f20c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 18:58:51.482052) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 18:58:51.482567) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 18:58:51.482899) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 18:58:51.497927) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 18:58:51.498250) ========= 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=826874ccc97bd7bf541b4875000001d5-1472781137.244611-209123321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-01 18:58:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.7M=0s 2016-09-01 18:58:51 (46.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.135276 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 18:58:51.650847) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 18:58:51.651176) ========= 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=826874ccc97bd7bf541b4875000001d5-1472781137.244611-209123321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020721 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 18:58:51.701684) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-01 18:58:51.702099) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4f8bafdd88dc6cfdb5b5fe074dfb5d1abdb2f20c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 4f8bafdd88dc6cfdb5b5fe074dfb5d1abdb2f20c --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1472781137.244611-209123321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-01 18:58:52,072 truncating revision to first 12 chars 2016-09-01 18:58:52,072 Setting DEBUG logging. 2016-09-01 18:58:52,072 attempt 1/10 2016-09-01 18:58:52,072 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4f8bafdd88dc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-01 18:58:52,762 unpacking tar archive at: fx-team-4f8bafdd88dc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.017985 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-01 18:58:52.736794) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 18:58:52.737377) ========= script_repo_revision: 4f8bafdd88dc6cfdb5b5fe074dfb5d1abdb2f20c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 18:58:52.738033) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 18:58:52.738545) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 18:58:52.751569) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-09-01 18:58:52.752046) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1472781137.244611-209123321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:58:53 INFO - MultiFileLogger online at 20160901 18:58:53 in /builds/slave/test 18:58:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 18:58:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:58:53 INFO - {'append_to_log': False, 18:58:53 INFO - 'base_work_dir': '/builds/slave/test', 18:58:53 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 18:58:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:58:53 INFO - 'branch': 'Fx-Team-Non-PGO', 18:58:53 INFO - 'buildbot_json_path': 'buildprops.json', 18:58:53 INFO - 'config_files': ('talos/linux_config.py',), 18:58:53 INFO - 'default_actions': ('clobber', 18:58:53 INFO - 'read-buildbot-config', 18:58:53 INFO - 'download-and-extract', 18:58:53 INFO - 'populate-webroot', 18:58:53 INFO - 'create-virtualenv', 18:58:53 INFO - 'install', 18:58:53 INFO - 'run-tests'), 18:58:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:58:53 INFO - 'download_minidump_stackwalk': True, 18:58:53 INFO - 'download_symbols': 'ondemand', 18:58:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:58:53 INFO - 'tooltool.py': '/tools/tooltool.py', 18:58:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:58:53 INFO - '/tools/misc-python/virtualenv.py')}, 18:58:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:58:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:58:53 INFO - 'installer_path': 'installer.exe', 18:58:53 INFO - 'log_level': 'info', 18:58:53 INFO - 'log_name': 'talos', 18:58:53 INFO - 'log_to_console': True, 18:58:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:58:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:58:53 INFO - 'opt_config_files': (), 18:58:53 INFO - 'pip_index': False, 18:58:53 INFO - 'sps_profile': False, 18:58:53 INFO - 'sps_profile_interval': 0, 18:58:53 INFO - 'suite': 'dromaeojs', 18:58:53 INFO - 'system_bits': '32', 18:58:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:58:53 INFO - 'title': 'talos-linux64-ix-052', 18:58:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:58:53 INFO - 'use_talos_json': True, 18:58:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:58:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:58:53 INFO - 'work_dir': 'build'} 18:58:53 INFO - [mozharness: 2016-09-02 01:58:53.214677Z] Running clobber step. 18:58:53 INFO - Running pre-action listener: _resource_record_pre_action 18:58:53 INFO - Running main action method: clobber 18:58:53 INFO - rmtree: /builds/slave/test/build 18:58:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:58:54 INFO - Running post-action listener: _resource_record_post_action 18:58:54 INFO - [mozharness: 2016-09-02 01:58:54.192534Z] Finished clobber step (success) 18:58:54 INFO - [mozharness: 2016-09-02 01:58:54.192635Z] Running read-buildbot-config step. 18:58:54 INFO - Running pre-action listener: _resource_record_pre_action 18:58:54 INFO - Running main action method: read_buildbot_config 18:58:54 INFO - Using buildbot properties: 18:58:54 INFO - { 18:58:54 INFO - "project": "", 18:58:54 INFO - "product": "firefox", 18:58:54 INFO - "script_repo_revision": "production", 18:58:54 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 18:58:54 INFO - "repository": "", 18:58:54 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 18:58:54 INFO - "buildid": "20160901175543", 18:58:54 INFO - "pgo_build": "False", 18:58:54 INFO - "basedir": "/builds/slave/test", 18:58:54 INFO - "buildnumber": 1913, 18:58:54 INFO - "slavename": "talos-linux64-ix-052", 18:58:54 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:58:54 INFO - "platform": "ubuntu64_hw", 18:58:54 INFO - "scheduler": "tests-fx-team-linux64-talos", 18:58:54 INFO - "branch": "fx-team", 18:58:54 INFO - "repo_path": "integration/fx-team", 18:58:54 INFO - "revision": "4f8bafdd88dc6cfdb5b5fe074dfb5d1abdb2f20c", 18:58:54 INFO - "stage_platform": "linux64", 18:58:54 INFO - "builduid": "2026aa1659c846dbbd3626fdd61c7bee", 18:58:54 INFO - "slavebuilddir": "test" 18:58:54 INFO - } 18:58:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/cGGtJNvVTsqvQiT7W1Ebeg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 18:58:54 INFO - Running post-action listener: _resource_record_post_action 18:58:54 INFO - [mozharness: 2016-09-02 01:58:54.195084Z] Finished read-buildbot-config step (success) 18:58:54 INFO - [mozharness: 2016-09-02 01:58:54.195173Z] Running download-and-extract step. 18:58:54 INFO - Running pre-action listener: _resource_record_pre_action 18:58:54 INFO - Running main action method: download_and_extract 18:58:54 INFO - mkdir: /builds/slave/test/build/tests 18:58:54 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')]} 18:58:54 INFO - trying https://queue.taskcluster.net/v1/task/cGGtJNvVTsqvQiT7W1Ebeg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 18:58:54 INFO - Downloading https://queue.taskcluster.net/v1/task/cGGtJNvVTsqvQiT7W1Ebeg/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 18:58:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cGGtJNvVTsqvQiT7W1Ebeg/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 18:58:54 INFO - Downloaded 1361 bytes. 18:58:54 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 18:58:54 INFO - Using the following test package requirements: 18:58:54 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 18:58:54 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:58:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:58:54 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:58:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:58:54 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:58:54 INFO - u'jsshell-linux-x86_64.zip'], 18:58:54 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:58:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:58:54 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 18:58:54 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:58:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:58:54 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:58:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:58:54 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:58:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:58:54 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:58:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:58:54 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:58:54 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')]} 18:58:54 INFO - trying https://queue.taskcluster.net/v1/task/cGGtJNvVTsqvQiT7W1Ebeg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 18:58:54 INFO - Downloading https://queue.taskcluster.net/v1/task/cGGtJNvVTsqvQiT7W1Ebeg/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 18:58:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cGGtJNvVTsqvQiT7W1Ebeg/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 18:58:55 INFO - Downloaded 20334556 bytes. 18:58:55 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 18:58:59 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 18:58: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')]} 18:58:59 INFO - trying https://queue.taskcluster.net/v1/task/cGGtJNvVTsqvQiT7W1Ebeg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 18:58:59 INFO - Downloading https://queue.taskcluster.net/v1/task/cGGtJNvVTsqvQiT7W1Ebeg/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 18:58:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cGGtJNvVTsqvQiT7W1Ebeg/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 18:59:00 INFO - Downloaded 20334556 bytes. 18:59:00 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 18:59:05 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')]} 18:59:05 INFO - trying https://queue.taskcluster.net/v1/task/cGGtJNvVTsqvQiT7W1Ebeg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 18:59:05 INFO - Downloading https://queue.taskcluster.net/v1/task/cGGtJNvVTsqvQiT7W1Ebeg/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 18:59:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cGGtJNvVTsqvQiT7W1Ebeg/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 18:59:06 INFO - Downloaded 14413998 bytes. 18:59:06 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 18:59: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')]} 18:59:06 INFO - trying https://queue.taskcluster.net/v1/task/cGGtJNvVTsqvQiT7W1Ebeg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 18:59:06 INFO - Downloading https://queue.taskcluster.net/v1/task/cGGtJNvVTsqvQiT7W1Ebeg/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 18:59:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cGGtJNvVTsqvQiT7W1Ebeg/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 18:59:07 INFO - Downloaded 55868550 bytes. 18:59:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cGGtJNvVTsqvQiT7W1Ebeg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 18:59:07 INFO - mkdir: /builds/slave/test/properties 18:59:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:59:07 INFO - Writing to file /builds/slave/test/properties/build_url 18:59:07 INFO - Contents: 18:59:07 INFO - build_url:https://queue.taskcluster.net/v1/task/cGGtJNvVTsqvQiT7W1Ebeg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 18:59:08 INFO - Running post-action listener: _resource_record_post_action 18:59:08 INFO - Running post-action listener: set_extra_try_arguments 18:59:08 INFO - [mozharness: 2016-09-02 01:59:08.580859Z] Finished download-and-extract step (success) 18:59:08 INFO - [mozharness: 2016-09-02 01:59:08.581089Z] Running populate-webroot step. 18:59:08 INFO - Running pre-action listener: _resource_record_pre_action 18:59:08 INFO - Running main action method: populate_webroot 18:59:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:59:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:59:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:59:08 INFO - '--tppagecycles', 18:59:08 INFO - '7'], 18:59:08 INFO - 'tests': ['tsvgm']}}, 18:59:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:59:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:59:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:59:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:59:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:59:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:59:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:59:08 INFO - 'talos_options': ['--disable-e10s'], 18:59:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:59:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:59:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:59:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:59:08 INFO - 'talos_options': ['--disable-e10s'], 18:59:08 INFO - 'tests': ['damp', 'tps']}, 18:59:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:59:08 INFO - 'tests': ['damp', 'tps']}, 18:59:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:59:08 INFO - 'tests': ['dromaeo_dom']}, 18:59:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:59:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:59:08 INFO - 'tests': ['basic_compositor_video']}, 18:59:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:59:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:59:08 INFO - 'tests': ['a11yr', 18:59:08 INFO - 'ts_paint', 18:59:08 INFO - 'tpaint', 18:59:08 INFO - 'sessionrestore', 18:59:08 INFO - 'sessionrestore_no_auto_restore', 18:59:08 INFO - 'tabpaint']}, 18:59:08 INFO - 'other-e10s': {'tests': ['a11yr', 18:59:08 INFO - 'ts_paint', 18:59:08 INFO - 'tpaint', 18:59:08 INFO - 'sessionrestore', 18:59:08 INFO - 'sessionrestore_no_auto_restore', 18:59:08 INFO - 'tabpaint']}, 18:59:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:59:08 INFO - 'ts_paint', 18:59:08 INFO - 'tpaint', 18:59:08 INFO - 'sessionrestore', 18:59:08 INFO - 'sessionrestore_no_auto_restore', 18:59:08 INFO - 'tabpaint']}, 18:59:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:59:08 INFO - 'ts_paint', 18:59:08 INFO - 'tpaint', 18:59:08 INFO - 'sessionrestore', 18:59:08 INFO - 'sessionrestore_no_auto_restore', 18:59:08 INFO - 'tabpaint']}, 18:59:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:59:08 INFO - 'tests': ['a11yr', 18:59:08 INFO - 'ts_paint', 18:59:08 INFO - 'tpaint', 18:59:08 INFO - 'sessionrestore', 18:59:08 INFO - 'sessionrestore_no_auto_restore', 18:59:08 INFO - 'tabpaint']}, 18:59:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:59:08 INFO - 'tests': ['a11yr', 18:59:08 INFO - 'ts_paint', 18:59:08 INFO - 'tpaint', 18:59:08 INFO - 'sessionrestore', 18:59:08 INFO - 'sessionrestore_no_auto_restore', 18:59:08 INFO - 'tabpaint']}, 18:59:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:59:08 INFO - 'tests': ['tsvgx', 18:59:08 INFO - 'tsvgr_opacity', 18:59:08 INFO - 'tart', 18:59:08 INFO - 'tscrollx', 18:59:08 INFO - 'cart']}, 18:59:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:59:08 INFO - 'tsvgr_opacity', 18:59:08 INFO - 'tart', 18:59:08 INFO - 'tscrollx', 18:59:08 INFO - 'cart']}, 18:59:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:59:08 INFO - 'talos_options': ['--disable-e10s'], 18:59:08 INFO - 'tests': ['tp5o']}, 18:59:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:59:08 INFO - 'tests': ['tp5o']}, 18:59:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:59:08 INFO - 'talos_options': ['--disable-e10s', 18:59:08 INFO - '--xperf_path', 18:59:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:59:08 INFO - 'tests': ['tp5n']}, 18:59:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:59:08 INFO - 'talos_options': ['--xperf_path', 18:59:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:59:08 INFO - 'tests': ['tp5n']}}, 18:59:08 INFO - 'talos.zip': {'path': '', 18:59:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:59:08 INFO - Running post-action listener: _resource_record_post_action 18:59:08 INFO - [mozharness: 2016-09-02 01:59:08.596817Z] Finished populate-webroot step (success) 18:59:08 INFO - [mozharness: 2016-09-02 01:59:08.596909Z] Running create-virtualenv step. 18:59:08 INFO - Running pre-action listener: _resource_record_pre_action 18:59:08 INFO - Running main action method: create_virtualenv 18:59:08 INFO - Creating virtualenv /builds/slave/test/build/venv 18:59:08 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 18:59:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:59:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:59:08 INFO - Using real prefix '/usr' 18:59:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:59:09 INFO - Installing distribute.............................................................................................................................................................................................done. 18:59:11 INFO - Installing pip.................done. 18:59:11 INFO - Return code: 0 18:59:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:59: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')]} 18:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59: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')]} 18:59:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f763cb45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f4420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2982d20>, '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 0x2983c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29840b0>, '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': '826874ccc97bd7bf541b4875000001d5-1472781137.244611-209123321', '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 18:59:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:59:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:59:11 INFO - Using env: {'DISPLAY': ':0', 18:59:11 INFO - 'HOME': '/home/cltbld', 18:59:11 INFO - 'LANG': 'en_US.UTF-8', 18:59:11 INFO - 'LANGUAGE': 'en_US:en', 18:59:11 INFO - 'LOGNAME': 'cltbld', 18:59:11 INFO - 'MAIL': '/var/mail/cltbld', 18:59:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:11 INFO - 'MOZ_NO_REMOTE': '1', 18:59:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:59:11 INFO - 'NO_EM_RESTART': '1', 18:59:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:59:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:11 INFO - 'PWD': '/builds/slave/test', 18:59:11 INFO - 'SHELL': '/bin/bash', 18:59:11 INFO - 'SHLVL': '1', 18:59:11 INFO - 'TERM': 'linux', 18:59:11 INFO - 'TMOUT': '86400', 18:59:11 INFO - 'USER': 'cltbld', 18:59:11 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1472781137.244611-209123321', 18:59:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:11 INFO - '_': '/tools/buildbot/bin/python'} 18:59:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:11 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 18:59:11 INFO - Cleaning up... 18:59:11 INFO - Return code: 0 18:59:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:59: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')]} 18:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59: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')]} 18:59:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59: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', '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 0x7f763cb45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f4420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2982d20>, '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 0x2983c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29840b0>, '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': '826874ccc97bd7bf541b4875000001d5-1472781137.244611-209123321', '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 18:59: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', 'psutil>=3.1.1'] in /builds/slave/test/build 18:59: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 psutil>=3.1.1 18:59:11 INFO - Using env: {'DISPLAY': ':0', 18:59:11 INFO - 'HOME': '/home/cltbld', 18:59:11 INFO - 'LANG': 'en_US.UTF-8', 18:59:11 INFO - 'LANGUAGE': 'en_US:en', 18:59:11 INFO - 'LOGNAME': 'cltbld', 18:59:11 INFO - 'MAIL': '/var/mail/cltbld', 18:59:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:11 INFO - 'MOZ_NO_REMOTE': '1', 18:59:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:59:11 INFO - 'NO_EM_RESTART': '1', 18:59:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:59:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:11 INFO - 'PWD': '/builds/slave/test', 18:59:11 INFO - 'SHELL': '/bin/bash', 18:59:11 INFO - 'SHLVL': '1', 18:59:11 INFO - 'TERM': 'linux', 18:59:11 INFO - 'TMOUT': '86400', 18:59:11 INFO - 'USER': 'cltbld', 18:59:11 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1472781137.244611-209123321', 18:59:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:11 INFO - '_': '/tools/buildbot/bin/python'} 18:59:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:11 INFO - Downloading/unpacking psutil>=3.1.1 18:59: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 18:59: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 18:59: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 18:59: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 18:59: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 18:59: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 18:59:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:59:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:59:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:59:13 INFO - Installing collected packages: psutil 18:59:13 INFO - Running setup.py install for psutil 18:59:13 INFO - building 'psutil._psutil_linux' extension 18:59:13 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 18:59:13 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 18:59:13 INFO - building 'psutil._psutil_posix' extension 18:59:13 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 18:59:13 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 18:59:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:59:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:59:14 INFO - Successfully installed psutil 18:59:14 INFO - Cleaning up... 18:59:14 INFO - Return code: 0 18:59:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:59:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f763cb45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f4420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2982d20>, '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 0x2983c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29840b0>, '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': '826874ccc97bd7bf541b4875000001d5-1472781137.244611-209123321', '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 18:59:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:59:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:59:14 INFO - Using env: {'DISPLAY': ':0', 18:59:14 INFO - 'HOME': '/home/cltbld', 18:59:14 INFO - 'LANG': 'en_US.UTF-8', 18:59:14 INFO - 'LANGUAGE': 'en_US:en', 18:59:14 INFO - 'LOGNAME': 'cltbld', 18:59:14 INFO - 'MAIL': '/var/mail/cltbld', 18:59:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:14 INFO - 'MOZ_NO_REMOTE': '1', 18:59:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:59:14 INFO - 'NO_EM_RESTART': '1', 18:59:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:59:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:14 INFO - 'PWD': '/builds/slave/test', 18:59:14 INFO - 'SHELL': '/bin/bash', 18:59:14 INFO - 'SHLVL': '1', 18:59:14 INFO - 'TERM': 'linux', 18:59:14 INFO - 'TMOUT': '86400', 18:59:14 INFO - 'USER': 'cltbld', 18:59:14 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1472781137.244611-209123321', 18:59:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:14 INFO - '_': '/tools/buildbot/bin/python'} 18:59:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:59: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 18:59: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 18:59: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 18:59: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 18:59: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 18:59: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 18:59:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:59:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:59:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:59:16 INFO - Installing collected packages: mozsystemmonitor 18:59:16 INFO - Running setup.py install for mozsystemmonitor 18:59:16 INFO - Successfully installed mozsystemmonitor 18:59:16 INFO - Cleaning up... 18:59:16 INFO - Return code: 0 18:59:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:59:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:16 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 0x7f763cb45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f4420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2982d20>, '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 0x2983c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29840b0>, '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': '826874ccc97bd7bf541b4875000001d5-1472781137.244611-209123321', '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 18:59:16 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 18:59:16 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 18:59:16 INFO - Using env: {'DISPLAY': ':0', 18:59:16 INFO - 'HOME': '/home/cltbld', 18:59:16 INFO - 'LANG': 'en_US.UTF-8', 18:59:16 INFO - 'LANGUAGE': 'en_US:en', 18:59:16 INFO - 'LOGNAME': 'cltbld', 18:59:16 INFO - 'MAIL': '/var/mail/cltbld', 18:59:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:16 INFO - 'MOZ_NO_REMOTE': '1', 18:59:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:59:16 INFO - 'NO_EM_RESTART': '1', 18:59:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:59:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:16 INFO - 'PWD': '/builds/slave/test', 18:59:16 INFO - 'SHELL': '/bin/bash', 18:59:16 INFO - 'SHLVL': '1', 18:59:16 INFO - 'TERM': 'linux', 18:59:16 INFO - 'TMOUT': '86400', 18:59:16 INFO - 'USER': 'cltbld', 18:59:16 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1472781137.244611-209123321', 18:59:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:16 INFO - '_': '/tools/buildbot/bin/python'} 18:59:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:16 INFO - Downloading/unpacking jsonschema==2.5.1 18:59:16 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 18:59:16 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 18:59:16 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 18:59:16 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 18:59:16 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 18:59:16 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 18:59:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:59:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:59:18 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 18:59:18 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 18:59:18 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 18:59:18 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 18:59:18 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 18:59:18 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 18:59:18 INFO - Downloading functools32-3.2.3-2.tar.gz 18:59:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:59:18 INFO - warning: no files found matching '*.txt' 18:59:18 INFO - no previously-included directories found matching 'build' 18:59:18 INFO - no previously-included directories found matching 'dist' 18:59:18 INFO - no previously-included directories found matching '.git*' 18:59:18 INFO - Installing collected packages: jsonschema, functools32 18:59:18 INFO - Running setup.py install for functools32 18:59:18 INFO - warning: no files found matching '*.txt' 18:59:18 INFO - no previously-included directories found matching 'build' 18:59:18 INFO - no previously-included directories found matching 'dist' 18:59:18 INFO - no previously-included directories found matching '.git*' 18:59:18 INFO - Successfully installed jsonschema functools32 18:59:18 INFO - Cleaning up... 18:59:18 INFO - Return code: 0 18:59:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:59: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')]} 18:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59: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')]} 18:59:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:18 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 0x7f763cb45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f4420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2982d20>, '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 0x2983c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29840b0>, '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': '826874ccc97bd7bf541b4875000001d5-1472781137.244611-209123321', '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 18:59:18 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 18:59:18 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 18:59:18 INFO - Using env: {'DISPLAY': ':0', 18:59:18 INFO - 'HOME': '/home/cltbld', 18:59:18 INFO - 'LANG': 'en_US.UTF-8', 18:59:18 INFO - 'LANGUAGE': 'en_US:en', 18:59:18 INFO - 'LOGNAME': 'cltbld', 18:59:18 INFO - 'MAIL': '/var/mail/cltbld', 18:59:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:18 INFO - 'MOZ_NO_REMOTE': '1', 18:59:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:59:18 INFO - 'NO_EM_RESTART': '1', 18:59:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:59:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:18 INFO - 'PWD': '/builds/slave/test', 18:59:18 INFO - 'SHELL': '/bin/bash', 18:59:18 INFO - 'SHLVL': '1', 18:59:18 INFO - 'TERM': 'linux', 18:59:18 INFO - 'TMOUT': '86400', 18:59:18 INFO - 'USER': 'cltbld', 18:59:18 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1472781137.244611-209123321', 18:59:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:18 INFO - '_': '/tools/buildbot/bin/python'} 18:59:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:59:19 INFO - Cleaning up... 18:59:19 INFO - Return code: 0 18:59:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:59:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f763cb45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f4420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2982d20>, '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 0x2983c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29840b0>, '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': '826874ccc97bd7bf541b4875000001d5-1472781137.244611-209123321', '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 18:59:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:59:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:59:19 INFO - Using env: {'DISPLAY': ':0', 18:59:19 INFO - 'HOME': '/home/cltbld', 18:59:19 INFO - 'LANG': 'en_US.UTF-8', 18:59:19 INFO - 'LANGUAGE': 'en_US:en', 18:59:19 INFO - 'LOGNAME': 'cltbld', 18:59:19 INFO - 'MAIL': '/var/mail/cltbld', 18:59:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:19 INFO - 'MOZ_NO_REMOTE': '1', 18:59:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:59:19 INFO - 'NO_EM_RESTART': '1', 18:59:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:59:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:19 INFO - 'PWD': '/builds/slave/test', 18:59:19 INFO - 'SHELL': '/bin/bash', 18:59:19 INFO - 'SHLVL': '1', 18:59:19 INFO - 'TERM': 'linux', 18:59:19 INFO - 'TMOUT': '86400', 18:59:19 INFO - 'USER': 'cltbld', 18:59:19 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1472781137.244611-209123321', 18:59:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:19 INFO - '_': '/tools/buildbot/bin/python'} 18:59:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:19 INFO - Downloading/unpacking blobuploader==1.2.4 18:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:21 INFO - Downloading blobuploader-1.2.4.tar.gz 18:59:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:59:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:59:21 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 18:59:21 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 18:59:21 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 18:59:21 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 18:59:21 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 18:59:21 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 18:59:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:59:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:59:21 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 18:59:21 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 18:59:21 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 18:59:21 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 18:59:21 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 18:59:21 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 18:59:21 INFO - Downloading docopt-0.6.1.tar.gz 18:59:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:59:22 INFO - Installing collected packages: blobuploader, requests, docopt 18:59:22 INFO - Running setup.py install for blobuploader 18:59:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:59:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:59:22 INFO - Running setup.py install for requests 18:59:22 INFO - Running setup.py install for docopt 18:59:22 INFO - Successfully installed blobuploader requests docopt 18:59:22 INFO - Cleaning up... 18:59:22 INFO - Return code: 0 18:59:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:59: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')]} 18:59:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59: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')]} 18:59:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:22 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 0x7f763cb45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f4420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2982d20>, '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 0x2983c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29840b0>, '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': '826874ccc97bd7bf541b4875000001d5-1472781137.244611-209123321', '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 18:59:22 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 18:59:22 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 18:59:22 INFO - Using env: {'DISPLAY': ':0', 18:59:22 INFO - 'HOME': '/home/cltbld', 18:59:22 INFO - 'LANG': 'en_US.UTF-8', 18:59:22 INFO - 'LANGUAGE': 'en_US:en', 18:59:22 INFO - 'LOGNAME': 'cltbld', 18:59:22 INFO - 'MAIL': '/var/mail/cltbld', 18:59:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:22 INFO - 'MOZ_NO_REMOTE': '1', 18:59:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:59:22 INFO - 'NO_EM_RESTART': '1', 18:59:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:59:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:22 INFO - 'PWD': '/builds/slave/test', 18:59:22 INFO - 'SHELL': '/bin/bash', 18:59:22 INFO - 'SHLVL': '1', 18:59:22 INFO - 'TERM': 'linux', 18:59:22 INFO - 'TMOUT': '86400', 18:59:22 INFO - 'USER': 'cltbld', 18:59:22 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1472781137.244611-209123321', 18:59:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:22 INFO - '_': '/tools/buildbot/bin/python'} 18:59:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:59:22 INFO - Running setup.py (path:/tmp/pip-0BWYaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:59:22 INFO - Running setup.py (path:/tmp/pip-XX2D_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:59:23 INFO - Running setup.py (path:/tmp/pip-IG7gMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:59:23 INFO - Running setup.py (path:/tmp/pip-QAjnlj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:59:23 INFO - Running setup.py (path:/tmp/pip-MYMe_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:59:23 INFO - Running setup.py (path:/tmp/pip-fa2nNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:59:23 INFO - Running setup.py (path:/tmp/pip-st8DN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:59:23 INFO - Running setup.py (path:/tmp/pip-m8M2HC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:59:23 INFO - Running setup.py (path:/tmp/pip-DDPpj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:59:23 INFO - Running setup.py (path:/tmp/pip-FNtYSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:59:23 INFO - Running setup.py (path:/tmp/pip-g7U_v_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:59:23 INFO - Running setup.py (path:/tmp/pip-efTrdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:59:23 INFO - Running setup.py (path:/tmp/pip-O3ygQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:59:23 INFO - Running setup.py (path:/tmp/pip-8jw08f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:59:23 INFO - Running setup.py (path:/tmp/pip-z8FQXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:59:23 INFO - Running setup.py (path:/tmp/pip-DTjFpx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:59:23 INFO - Running setup.py (path:/tmp/pip-RDCfD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:59:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:59:24 INFO - Running setup.py install for manifestparser 18:59:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:59:24 INFO - Running setup.py install for mozcrash 18:59:24 INFO - Running setup.py install for mozdebug 18:59:24 INFO - Running setup.py install for mozdevice 18:59:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:59:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:59:24 INFO - Running setup.py install for mozfile 18:59:24 INFO - Running setup.py install for mozhttpd 18:59:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:59:24 INFO - Running setup.py install for mozinfo 18:59:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:59:24 INFO - Running setup.py install for mozInstall 18:59:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:59:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:59:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:59:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:59:24 INFO - Running setup.py install for mozleak 18:59:24 INFO - Running setup.py install for mozlog 18:59:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:59:25 INFO - Running setup.py install for moznetwork 18:59:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:59:25 INFO - Running setup.py install for mozprocess 18:59:25 INFO - Running setup.py install for mozprofile 18:59:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:59:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:59:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:59:25 INFO - Running setup.py install for mozrunner 18:59:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:59:25 INFO - Running setup.py install for mozscreenshot 18:59:25 INFO - Running setup.py install for moztest 18:59:25 INFO - Running setup.py install for mozversion 18:59:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:59:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:59:25 INFO - Cleaning up... 18:59:25 INFO - Return code: 0 18:59:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:59:25 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')]} 18:59:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:25 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')]} 18:59:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:25 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 0x7f763cb45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f4420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2982d20>, '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 0x2983c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29840b0>, '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': '826874ccc97bd7bf541b4875000001d5-1472781137.244611-209123321', '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 18:59:25 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 18:59:25 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 18:59:25 INFO - Using env: {'DISPLAY': ':0', 18:59:25 INFO - 'HOME': '/home/cltbld', 18:59:25 INFO - 'LANG': 'en_US.UTF-8', 18:59:25 INFO - 'LANGUAGE': 'en_US:en', 18:59:25 INFO - 'LOGNAME': 'cltbld', 18:59:25 INFO - 'MAIL': '/var/mail/cltbld', 18:59:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:25 INFO - 'MOZ_NO_REMOTE': '1', 18:59:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:59:25 INFO - 'NO_EM_RESTART': '1', 18:59:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:59:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:25 INFO - 'PWD': '/builds/slave/test', 18:59:25 INFO - 'SHELL': '/bin/bash', 18:59:25 INFO - 'SHLVL': '1', 18:59:25 INFO - 'TERM': 'linux', 18:59:25 INFO - 'TMOUT': '86400', 18:59:25 INFO - 'USER': 'cltbld', 18:59:25 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1472781137.244611-209123321', 18:59:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:25 INFO - '_': '/tools/buildbot/bin/python'} 18:59:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:59:26 INFO - Running setup.py (path:/tmp/pip-vMMAr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:59:26 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:59:26 INFO - Running setup.py (path:/tmp/pip-FTuJKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:59:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:59:26 INFO - Running setup.py (path:/tmp/pip-_oamFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:59:26 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)) 18:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:59:26 INFO - Running setup.py (path:/tmp/pip-NbJiIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:59:26 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)) 18:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:59:26 INFO - Running setup.py (path:/tmp/pip-sPwjw8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:59:26 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)) 18:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:59:26 INFO - Running setup.py (path:/tmp/pip-hsLGi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:59:26 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)) 18:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:59:26 INFO - Running setup.py (path:/tmp/pip-8ipl0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:59:26 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)) 18:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:59:26 INFO - Running setup.py (path:/tmp/pip-W3gdYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:59:26 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)) 18:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:59:26 INFO - Running setup.py (path:/tmp/pip-WUiOiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:59:26 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)) 18:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:59:26 INFO - Running setup.py (path:/tmp/pip-89ZnNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:59:26 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)) 18:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:59:26 INFO - Running setup.py (path:/tmp/pip-YUJqLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:59:26 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)) 18:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:59:26 INFO - Running setup.py (path:/tmp/pip-YF_5Lg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:59:26 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)) 18:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:59:26 INFO - Running setup.py (path:/tmp/pip-bewLw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:59:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:59:27 INFO - Running setup.py (path:/tmp/pip-nrf2pY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:59:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:59:27 INFO - Running setup.py (path:/tmp/pip-BjSjGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:59:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:59:27 INFO - Running setup.py (path:/tmp/pip-Ir7kx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:59:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:59:27 INFO - Running setup.py (path:/tmp/pip-0xRawB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:59:27 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)) 18:59:27 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)) 18:59:27 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)) 18:59:27 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)) 18:59:27 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)) 18:59:27 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)) 18:59:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:59:27 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 18:59:27 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 18:59:27 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 18:59:27 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 18:59:27 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 18:59:27 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 18:59:29 INFO - Downloading blessings-1.6.tar.gz 18:59:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:59:29 INFO - Installing collected packages: blessings 18:59:29 INFO - Running setup.py install for blessings 18:59:29 INFO - Successfully installed blessings 18:59:29 INFO - Cleaning up... 18:59:29 INFO - Return code: 0 18:59:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:59:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:59:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:59:29 INFO - Reading from file tmpfile_stdout 18:59:29 INFO - Current package versions: 18:59:29 INFO - argparse == 1.2.1 18:59:29 INFO - blessings == 1.6 18:59:29 INFO - blobuploader == 1.2.4 18:59:29 INFO - docopt == 0.6.1 18:59:29 INFO - functools32 == 3.2.3-2 18:59:29 INFO - jsonschema == 2.5.1 18:59:29 INFO - manifestparser == 1.1 18:59:29 INFO - mozInstall == 1.12 18:59:29 INFO - mozcrash == 0.17 18:59:29 INFO - mozdebug == 0.1 18:59:29 INFO - mozdevice == 0.48 18:59:29 INFO - mozfile == 1.2 18:59:29 INFO - mozhttpd == 0.7 18:59:29 INFO - mozinfo == 0.9 18:59:29 INFO - mozleak == 0.1 18:59:29 INFO - mozlog == 3.3 18:59:29 INFO - moznetwork == 0.27 18:59:29 INFO - mozprocess == 0.23 18:59:29 INFO - mozprofile == 0.28 18:59:29 INFO - mozrunner == 6.12 18:59:29 INFO - mozscreenshot == 0.1 18:59:29 INFO - mozsystemmonitor == 0.3 18:59:29 INFO - moztest == 0.7 18:59:29 INFO - mozversion == 1.4 18:59:29 INFO - psutil == 3.1.1 18:59:29 INFO - requests == 1.2.3 18:59:29 INFO - wsgiref == 0.1.2 18:59:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:29 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 0x7f763cb45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f4420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2982d20>, '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 0x2983c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29840b0>, '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': '826874ccc97bd7bf541b4875000001d5-1472781137.244611-209123321', '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 18:59:29 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 18:59:29 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 18:59:29 INFO - Using env: {'DISPLAY': ':0', 18:59:29 INFO - 'HOME': '/home/cltbld', 18:59:29 INFO - 'LANG': 'en_US.UTF-8', 18:59:29 INFO - 'LANGUAGE': 'en_US:en', 18:59:29 INFO - 'LOGNAME': 'cltbld', 18:59:29 INFO - 'MAIL': '/var/mail/cltbld', 18:59:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:29 INFO - 'MOZ_NO_REMOTE': '1', 18:59:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:59:29 INFO - 'NO_EM_RESTART': '1', 18:59:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:59:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:29 INFO - 'PWD': '/builds/slave/test', 18:59:29 INFO - 'SHELL': '/bin/bash', 18:59:29 INFO - 'SHLVL': '1', 18:59:29 INFO - 'TERM': 'linux', 18:59:29 INFO - 'TMOUT': '86400', 18:59:29 INFO - 'USER': 'cltbld', 18:59:29 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1472781137.244611-209123321', 18:59:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:29 INFO - '_': '/tools/buildbot/bin/python'} 18:59:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:29 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)) 18:59:29 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)) 18:59:29 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)) 18:59:29 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)) 18:59:29 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)) 18:59:29 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)) 18:59:29 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)) 18:59:29 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)) 18:59:29 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)) 18:59:29 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)) 18:59:29 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)) 18:59:29 INFO - Cleaning up... 18:59:29 INFO - Return code: 0 18:59:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:29 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 0x7f763cb45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f4420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2982d20>, '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 0x2983c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29840b0>, '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': '826874ccc97bd7bf541b4875000001d5-1472781137.244611-209123321', '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 18:59:29 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 18:59:29 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 18:59:29 INFO - Using env: {'DISPLAY': ':0', 18:59:29 INFO - 'HOME': '/home/cltbld', 18:59:29 INFO - 'LANG': 'en_US.UTF-8', 18:59:29 INFO - 'LANGUAGE': 'en_US:en', 18:59:29 INFO - 'LOGNAME': 'cltbld', 18:59:29 INFO - 'MAIL': '/var/mail/cltbld', 18:59:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:29 INFO - 'MOZ_NO_REMOTE': '1', 18:59:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:59:29 INFO - 'NO_EM_RESTART': '1', 18:59:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:59:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:29 INFO - 'PWD': '/builds/slave/test', 18:59:29 INFO - 'SHELL': '/bin/bash', 18:59:29 INFO - 'SHLVL': '1', 18:59:29 INFO - 'TERM': 'linux', 18:59:29 INFO - 'TMOUT': '86400', 18:59:29 INFO - 'USER': 'cltbld', 18:59:29 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1472781137.244611-209123321', 18:59:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:29 INFO - '_': '/tools/buildbot/bin/python'} 18:59:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:59:30 INFO - Cleaning up... 18:59:30 INFO - Return code: 0 18:59:30 INFO - Running post-action listener: _resource_record_post_action 18:59:30 INFO - Running post-action listener: _start_resource_monitoring 18:59:30 INFO - Starting resource monitoring. 18:59:30 INFO - [mozharness: 2016-09-02 01:59:30.108207Z] Finished create-virtualenv step (success) 18:59:30 INFO - [mozharness: 2016-09-02 01:59:30.108665Z] Running install step. 18:59:30 INFO - Running pre-action listener: _resource_record_pre_action 18:59:30 INFO - Running main action method: install 18:59:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:59:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:59:30 INFO - Reading from file tmpfile_stdout 18:59:30 INFO - Detecting whether we're running mozinstall >=1.0... 18:59:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:59:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:59:30 INFO - Reading from file tmpfile_stdout 18:59:30 INFO - Output received: 18:59:30 INFO - Usage: mozinstall [options] installer 18:59:30 INFO - Options: 18:59:30 INFO - -h, --help show this help message and exit 18:59:30 INFO - -d DEST, --destination=DEST 18:59:30 INFO - Directory to install application into. [default: 18:59:30 INFO - "/builds/slave/test"] 18:59:30 INFO - --app=APP Application being installed. [default: firefox] 18:59:30 INFO - mkdir: /builds/slave/test/build/application 18:59:30 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'] 18:59:30 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 18:59:47 INFO - Reading from file tmpfile_stdout 18:59:47 INFO - Output received: 18:59:47 INFO - /builds/slave/test/build/application/firefox/firefox 18:59:47 INFO - Running post-action listener: _resource_record_post_action 18:59:47 INFO - [mozharness: 2016-09-02 01:59:47.061395Z] Finished install step (success) 18:59:47 INFO - [mozharness: 2016-09-02 01:59:47.061678Z] Running run-tests step. 18:59:47 INFO - Running pre-action listener: _resource_record_pre_action 18:59:47 INFO - Running main action method: run_tests 18:59:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:59:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:59:47 INFO - Python 2.7.3 18:59:47 INFO - Return code: 0 18:59:47 INFO - grabbing minidump binary from tooltool 18:59:47 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')]} 18:59:47 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 0x2982d20>, '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 0x2983c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29840b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:59:47 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 18:59:47 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 18:59:47 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 18:59:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:59:47 INFO - Return code: 0 18:59:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:59:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:59:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:59:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:59:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:59:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cGGtJNvVTsqvQiT7W1Ebeg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 18:59:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cGGtJNvVTsqvQiT7W1Ebeg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-052 --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 18:59:47 INFO - Using env: {'DISPLAY': ':0', 18:59:47 INFO - 'HOME': '/home/cltbld', 18:59:47 INFO - 'LANG': 'en_US.UTF-8', 18:59:47 INFO - 'LANGUAGE': 'en_US:en', 18:59:47 INFO - 'LOGNAME': 'cltbld', 18:59:47 INFO - 'MAIL': '/var/mail/cltbld', 18:59:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:59:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:59:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:47 INFO - 'MOZ_NO_REMOTE': '1', 18:59:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:59:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:59:47 INFO - 'NO_EM_RESTART': '1', 18:59:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:59:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:47 INFO - 'PWD': '/builds/slave/test', 18:59:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:59:47 INFO - 'SHELL': '/bin/bash', 18:59:47 INFO - 'SHLVL': '1', 18:59:47 INFO - 'TERM': 'linux', 18:59:47 INFO - 'TMOUT': '86400', 18:59:47 INFO - 'USER': 'cltbld', 18:59:47 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1472781137.244611-209123321', 18:59:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:47 INFO - '_': '/tools/buildbot/bin/python'} 18:59:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cGGtJNvVTsqvQiT7W1Ebeg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 18:59:47 INFO - mozversion application_buildid: 20160901175543 18:59:47 INFO - mozversion application_changeset: 4f8bafdd88dc6cfdb5b5fe074dfb5d1abdb2f20c 18:59:47 INFO - mozversion application_display_name: Nightly 18:59:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:59:47 INFO - mozversion application_name: Firefox 18:59:47 INFO - mozversion application_remotingname: firefox 18:59:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:59:47 INFO - mozversion application_vendor: Mozilla 18:59:47 INFO - mozversion application_version: 51.0a1 18:59:47 INFO - mozversion platform_buildid: 20160901175543 18:59:47 INFO - mozversion platform_changeset: 4f8bafdd88dc6cfdb5b5fe074dfb5d1abdb2f20c 18:59:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:59:47 INFO - mozversion platform_version: 51.0a1 18:59:47 INFO - using testdate: 1472781587 18:59:47 INFO - actual date: 1472781587 18:59:47 INFO - starting webserver on 'localhost:56456' 18:59:47 INFO - SUITE-START | Running 2 tests 18:59:47 INFO - TEST-START | dromaeo_css 18:59:47 INFO - operating with platform_type : linux_ 18:59:47 INFO - Initialising browser for dromaeo_css test... 18:59:47 INFO - TEST-INFO | started process 2191 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp89dVAJ/profile http://localhost:56456/getInfo.html) 18:59:51 INFO - PROCESS | 2191 | __metrics Screen width/height:1600/1200 18:59:51 INFO - PROCESS | 2191 | colorDepth:24 18:59:51 INFO - PROCESS | 2191 | Browser inner width/height: 1024/697 18:59:51 INFO - PROCESS | 2191 | __metrics 18:59:52 INFO - PROCESS | 2191 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:59:52 INFO - PROCESS | 2191 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:59:52 INFO - PROCESS | 2191 | console.error: PushService: 18:59:52 INFO - PROCESS | 2191 | stateChangeProcessEnqueue: Error transitioning state 18:59:52 INFO - PROCESS | 2191 | UnknownError 18:59:53 INFO - TEST-INFO | 2191: exit 0 18:59:53 INFO - Browser initialized. 18:59:53 INFO - Running cycle 1/1 for dromaeo_css test... 18:59:53 INFO - TEST-INFO | started process 2270 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp89dVAJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:00:05 INFO - PROCESS | 2270 | RSS: Main: 180957184 19:00:05 INFO - PROCESS | 2270 | 19:00:56 INFO - PROCESS | 2270 | 1472781656893 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] 19:03:10 INFO - PROCESS | 2270 | Cycle 1(1): loaded http://localhost:56456/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56456/tests/dromaeo/cssquery-ext.html) 19:03:11 INFO - PROCESS | 2270 | RSS: Main: 285167616 19:03:11 INFO - PROCESS | 2270 | 19:06:14 INFO - PROCESS | 2270 | Cycle 1(1): loaded http://localhost:56456/tests/dromaeo/cssquery-ext.html (next: http://localhost:56456/tests/dromaeo/cssquery-jquery.html) 19:06:14 INFO - PROCESS | 2270 | RSS: Main: 273473536 19:06:14 INFO - PROCESS | 2270 | 19:09:17 INFO - PROCESS | 2270 | Cycle 1(1): loaded http://localhost:56456/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56456/tests/dromaeo/cssquery-mootools.html) 19:09:17 INFO - PROCESS | 2270 | RSS: Main: 241160192 19:09:17 INFO - PROCESS | 2270 | 19:12:19 INFO - PROCESS | 2270 | Cycle 1(1): loaded http://localhost:56456/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56456/tests/dromaeo/cssquery-prototype.html) 19:12:20 INFO - PROCESS | 2270 | RSS: Main: 219721728 19:12:20 INFO - PROCESS | 2270 | 19:15:23 INFO - PROCESS | 2270 | Cycle 1(1): loaded http://localhost:56456/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56456/tests/dromaeo/cssquery-yui.html) 19:15:24 INFO - PROCESS | 2270 | RSS: Main: 220426240 19:15:24 INFO - PROCESS | 2270 | 19:18:27 INFO - PROCESS | 2270 | Cycle 1(1): loaded http://localhost:56456/tests/dromaeo/cssquery-yui.html (next: http://localhost:56456/tests/dromaeo/cssquery-dojo.html) 19:18:27 INFO - PROCESS | 2270 | RSS: Main: 306130944 19:18:27 INFO - PROCESS | 2270 | 19:18:27 INFO - PROCESS | 2270 | __start_tp_report 19:18:27 INFO - PROCESS | 2270 | _x_x_mozilla_page_load 19:18:27 INFO - PROCESS | 2270 | _x_x_mozilla_page_load_details 19:18:27 INFO - PROCESS | 2270 | |i|pagename|runs| 19:18:27 INFO - PROCESS | 2270 | |0;dojo.html;2609.034657176845;2627.19870439516;2629.88165532551;2685.0065475773954;2691.5962605609157;4575.199340115483;4624.930626040604;4696.7416792076465;4769.070031343885;4837.105135549921;4624.445066592005;4649.837255696051;4667.813287468505;4675.929861052078;4709.788059537321;4374.562543745624;4391.451068616423;4473.686841921067;4476.753778542179;4495.190865644183;4412.338149277602;4450.621697155746;4450.643948484129;4474.23937930551;4486.170058539181;4381.3647021181905;4567.977160114211;4570.4972453030305;4571.2000399929875;4577.359169716243;4276.700630955835;4396.582324679166;4401.801918913625;4434.467863856358;4466.084452687224;4258.872233832959;4279.572042795696;4291.828326866922;4307.396964424983;4323.805428755682;4659.860204193846;4671.369365135731;4673.672842900998;4754.833580824655;4801.087793319293;5037.4458809530925;5075.314832497603;5086.262491938685;5089.312942752718;5142.562882155022;4970.105381031413;5112.974435127838;5164.948350516484;5173.663711858717;5179.870503237412;4781.545753153445;4789.9042019160115;4803.711777293303;4805.038992201574;4811.855644330711;5055.87360315995;5310.044192045391;5311.787528498817;5318;5360.437154098841;4966.354373931365;5012.498750125032;5017.122003649347;5019.0965626187635;5104.157813960729;5116.488351164854;5134.794608215704;5135.204043373283;5136.512031357015;5195.506426889439;4925.581325587294;5091.821786237464;5092.439831618519;5098.617603679739;5102.974485127551;4975.577075948585;5043.84868453947;5047.621428392885;5048.646594738333;5050.166722490748;4323.048929235563;4346.087321662423;4359.738415695068;4361.171377438277;4362.498312694017;3775.7923314217983;3838.1747924196434;3839.731218814712;3853.824583502059;3874.0121269076203;4430.689851710414;4438.578335058164;4440.111977604492;4440.422745043188;4496.595306422438;4957.132501812169;5136.178211486144;5140.254663073833;5146.691198528026;5202.323697919246;4405.669574781904;4411;4437.733735975852;4440.71135376206;4501.639868810487;4607.9308810367875;4615.469221039556;4615.561521655437;4619.099275641218;4674.275487299406;4644.60520855731;4800.415862765279;4859.659823812441;4864.148773964613;4920.237363208708;5085.262636917552;5107.412647545431;5126.564242039469;5129.307543481582;5179.22311653255;4838.419389673121;4845.079434907357;4849.733264670477;4849.854504364875;4900.95099049005;4813.205821039489;5037.7733002014265;5047.41954675217;5050.116229659869;5108.182690769459;5073.086844368049;5081;5121.385433747974;5121.462246464068;5159.948400516097;4969.378827646544;4979.676321039121;4990.900181996412;4997.900041999213;5046.899062018666;4730.952690473051;4970.850874473772;4983.327250821238;4990.625703072356;5053.924191137063;4816.710997340171;4862.027594481188;4863.319135321129;4868;4898.461169271306;4953.801847926186;4964.826231081895;4966.230234313687;4977.9751101244265;5019.297298378157;4806.47128815837;4850.733209673502;4858.659893807399;4863.294822250825;4863.465018847854 19:18:27 INFO - PROCESS | 2270 | |1;ext.html;568.2328856044338;568.7639629553736;572.790931310072;581.1428143488355;583.1893667801756;28045.298867528323;37208.627913720855;38696.419553706684;38714.22571548567;42470.36294455578;40016.199676006465;40269.798651006706;40329.39505907414;40336.39495407571;40442.797786011026;7776.222377762221;7927.484713493604;7935.642896069662;7936.087349954742;7937.206279372045;7738.7678369649;7816.17930117338;7820.061592608895;7826.373890088779;7827.295543401093;7825.647845846951;7892.289693927545;7892.486988345768;7904.762857114296;7908.841823163533;7816.218378162195;7862.685492580347;7866.41001924855;7867.252611001945;7869.2130786921425;7746.961265193638;7821.452498325119;7822.882656760153;7831.804204894866;7834.177411371781;38211.61788382108;38510.22979540394;38514.422283665765;38558;38633.80683096594;2772.182206249141;2808.36811717364;2936.750376218024;3207.182168547029;3404.5403870477417;27976.860115699496;28557.57163642547;28589.28526786847;28782.568261475884;29964;3492.1269682579355;3535.1338921964025;3539.9115022124397;3599.5500562429697;3622.7826330420257;239087;239479;239585;239631.99999999825;240321;31668.83311668861;32351.838240809117;50995.49004509982;51229;51274.487255127715;31862.884799031923;32169.195770105936;32170.19574510609;32181.35637287241;32184;12232.633021009384;12303.384830758427;12304.138710290194;12314.876851231553;12315;10171.694849154537;10217.18262538995;10252.23108266883;10283.691489255334;10303.278770485995;7592.392608591299;7686.077670679442;7712.614369281626;7714.729984450517;7741.07107147146;3029.4546981543535;3064.2033071401597;3074.1699741069788;3120.1731541141617;3150.57467241924;808.9069756977905;842.8314337132598;875.8861348024843;973.8149751547184;1016.415561052383;29055;31601;31762.682373176434;31783.84108079445;32225.838870805495;909.4361495872469;930.237205491504;934.4766930518796;965.8309795785709;1015.1067060986433;13860.653483662989;14610.269486525844;14724.411023558938;14972;15178.772318415233;397039;400029;400409;400511;401801;48022.75988620034;48570;48590.27114593284;48715.26927096096;48755.75622121867;1043.5669197283194;1160.785254727878;1178.988210117905;1179.0803173524664;1195.2231049817688;27540.173794786187;28524.85737571299;29122.27194320159;29401.558976615797;29610.111696649135;41126;42050.789746052295;42068;42112.789436052626;42147.15705685808;326201;328863;328933;329067;329380;21723.674144888155;23574.88212558926;23728.52542949166;23970.88014559916;24416.877915611018;39714.40428393634;40090.599094008685;40110.19779604333;40159.19681606293;40852;34318.65681343254;34675.826620867745;34802.30395392027;35005;35695.82152089223;34405;34589;34751.65248347585;34894.825525872206;35275.82362088173;33403.83298083591;33785.66214337923;34514.654853451146;34566.48150277697;34778.30443391169;30188.69811301859;31604;31668.683313166573;31709.20726981844;31972.520412194302;24200.961092231555;24445.38886527851;24687.5687348783;24833.379165521008;24844.627330590418 19:18:27 INFO - PROCESS | 2270 | |2;jquery.html;348.6043340808182;365.19656755138703;376.8812823960452;379.9183175617243;387.3956627660849;12225.938870305647;13703.10929789563;16287.918560407212;16403.343866245337;16417.179141042943;15964.361425542964;16320.673586528292;16415;16464.506064818044;16470.505884823444;4337.501187363462;4526.366308716782;4591.058832939239;4655;4680.438347398317;3478.808665523395;3562.091666625007;4629.7222166669935;4671.85984420468;4680.4149481314835;3682.4476328550663;3742.7941463219513;5938.703064846762;5977.521798256151;6052.727627256762;5815.214945982323;6050.789842031567;6062.363451837559;6065.7573697052285;6067.939320606782;5304.787808487656;5321.2284218788445;5339.786408543654;5345.037893179227;5348.171033489815;12386.62840114798;12458.81311780324;12672.176308539916;12676.2394256344;12789.360531973363;1786.8391844734037;1799.703048996914;1891.8297353238274;2262.7171603549555;2371.5731168389684;8999.640014399416;10350.58597656093;12850.357482125857;13100;13580.117292376062;1662.1523023258105;1668.6162182697926;1673.9748903766454;1695.6608678264274;1707.6840784454791;47101.52898471006;65303.673481632766;72959.27040729577;73702;74510;10041;10122.493875306205;10153.289269751194;10254.948725256476;10410.531526081344;13986.930065349812;14000.159990400609;14004.43982240699;14009.71980560383;14011.229382384066;7107.466939979522;7198.964005179941;7411.518251313755;7448.962755186298;7472.215417381097;6831.248562658104;6881.380675739108;6881.518293719491;7043.049188359506;7059.435245180373;4308.784560771949;4319.913601727948;4383.758893260838;4415.205263052681;4466.932996005063;1794.5603327184663;1806.8102849200907;1857.58204404008;1886.1700851625242;1895.8198971097725;755.7014979083341;907.328576853124;912.6278401307238;915.1534830281962;916.7295647783919;16389.59026024359;16407.83592164063;16577.91711041437;17031.65936681284;17453.12734363277;828.1842385250524;877.3902138014147;884.8716936044237;886.6719313853915;889.9466032038099;9134;9156.542172891328;9727.951360243154;9848.753781155528;9955.352902061342;290802;293633;294790;376928;378629;49615.50384496181;58155;80143.59928200321;81923;85695;880.6125304865839;893.3924931046951;928.2202949522299;929.1544694328129;933.0902370189011;14489.275536222936;15486.922565387102;15791.289391977618;16300.592485187492;16488.752668709738;37719;38893.805530973295;39053.609463905;39439.2112157761;41643.58356416518;45717.1319702134;48274.517254827006;51663.48336516737;52230.21654675259;52325.215121772446;6955.930440695528;7117.501774875709;7232.385247254042;7416.406687465098;7608.16310205888;10020.549075291483;10852;11057.391843448688;11151.776964460503;11336.829947550628;9491.952540237531;9642.903570964201;9679.93364843654;9829.361091529028;10050.346727462691;8835.69075082369;9328.207102396373;9542.570584323861;9564.330496865152;9858.802823943624;8734.475931444134;9053;9250.583723732583;9295.67465138717;10055.145312648507;7126.893096603451;7212.531185472927;7352.632368381453;7416.295451932057;7649.541027538366;7324.96337518309;9198.402103863227;9323.347365684336;9570.617175313188;9872.308938374244 19:18:27 INFO - PROCESS | 2270 | |3;mootools.html;1216.5924415320867;1303.1855090568395;1376.6489545165982;1415.2569900802077;1704.7698560694303;7607.885881711772;7936.801579960504;8010.91989080109;8197.795055123624;8212.055613604438;8008.799780005503;8116.350691944645;8128.471649342789;8131.308838748713;8134.593270336489;2208.1719355241785;2228.6099932511825;2231.4421394651336;2233.564454931289;2234.4637287051073;2170.565886822642;2200.8129309008673;2203.834712396577;2207.6467765157577;2208.8122509586706;2193.6928829963817;2195.769444208351;2207.1612787140944;2207.3046990198036;2237.8881055947218;2144.2923835134447;2144.871307721526;2148.3125399872047;2149.032935179168;2150.5053837617434;2105.810477057072;2140.315099168267;2141.635921893282;2142.8071473567297;2144.3352560706076;7852.921470785276;8081.4747041442115;8121.8223357612815;8131.349492040623;8138.226868447488;4451.866444006685;4557.931631025537;4571.062932098945;4578.542145785428;4589.678722489427;2813.3529288263608;2893.3489964757973;2929.8095623784598;2934.7065293470696;2944.2933695912825;915.0803442540271;917.124146440148;919.9862002069974;927.3832901120746;943.8395472769646;10870.402127882964;10964.945175274073;10965.287256328393;10968.561257549689;10973.561057557688;3909.3158697227873;4083.1833633273463;4192.266353388206;4238.491381034296;4241.172971270573;8094.757157285291;8095.311898488694;8100.270975612106;8107.554084525408;8112.310453611509;4414.741798587387;4418.491873434532;4420.889477763018;4422.380866678667;4427.424434823517;3521.8591256349973;3944.290027794967;4089.386592011222;4095.877123686294;4104.220198162339;3339.3655205510877;3348.179695974502;3452.5684289463816;3462.6191118976894;3515.4375299951885;1017.8829434614966;1041.250299784154;1042.3016578892161;1048.8059708953867;1063.1335461598771;659.4197106546209;766.3907193780846;773.6131934032984;795.0816806588284;808.4219782855287;4886.29148773433;4974.950250497521;4980.751676786968;5056.443791182967;5134.152864777345;396.55189635712037;403.16544752362915;412.142743094363;413.89445691348516;413.9648129908931;3444.7244220462303;3499.7725147865817;3523.3834079036064;3523.6300188480354;3675.7794532328144;9083.81832363349;9383.483908385104;9467.76330591727;9481.33630645862;9496.287778416647;9449.66926157595;9476.431414115175;9523.761905952406;9527.190188834027;9531.38046027006;7228.602426866468;7236.204017558064;7254.802957511952;7259.382952449101;7280.635968201569;4791.808327666854;4831.275308703723;4904.583110435653;4949.752512374439;5112.821051263188;8829.072947340437;8837.160469755363;8864.911350886667;8886.60010299551;8889.688860889837;8859.911400886167;8930.598123084346;8933.19601235892;8962.32782541299;9064.048274931301;5566.636174137362;6096.207493025879;6154.661493617894;6156.815295541141;6215.689215539295;7722.420818438752;7737.342325902361;7737.497062691133;7763.961180194063;7779.7666070017995;6735.225449073419;6775.966120169368;6789.62657053847;6801.7279308829075;6926.792196234121;6729.125213722381;6748.089007983859;6859.657017149222;6909.1018167637885;6946.6179360135675;6143.877122457437;6226.875462490634;6236.875262494816;6239.688015599111;6239.688015599111;4238.3430568261965;4331.306990881444;4411.602955733999;4434;4479.260921947973;4522.118186953644;4587.357769912148;4690.718556886462;4714.4106986626675;4864.270359446112 19:18:27 INFO - PROCESS | 2270 | |4;prototype.html;299.5895622996494;305.56457048705596;312.10114869176766;312.48752046643494;316.39726321357824;4814.085323788482;4852.320675105488;4860.65975381723;4872.4640289568115;4893.8287159949405;4777;4798.424189097304;4848.587870031043;4862.683925544837;4871.5615594596475;3847.480590120333;3854.807259637007;3861.6636934654553;3889.755278310942;3907.921841563167;3773.2264885698505;3838.309104361214;3851.614838516154;3891.416287556861;3905.7656540607513;3788;3816.7709937403843;3839.5584507781546;3852.5569559500595;3858.9807050964846;3795.3737633290475;3795.3927371620407;3804.334241507725;3807.3337165996118;3815.2369526094753;3166.9208269793207;3277.655846136169;3389.7288216942584;3406;3428.074419906636;4680.297955306697;4688.578027977464;4696.060787842411;4702.177119004161;4708.811647534095;4355.802154407532;4393.494748103945;4395.450568678915;4401.493828209733;4404.273294906337;4780.832670856538;4797.928031079537;4834.444038935532;4937.395346512398;5035.974820125876;3658.487811706363;3670.247599242149;3670.871519496805;3682.963170368316;3693.132113953219;5239.47605239473;5248.895022099575;5249.86875328116;5254.21186821976;5299.7810503584005;3685.244524872395;3720.404735242348;3736.393350859102;3756.6055564165367;3796.9430458543143;3820.7707537547835;3823.9617603824163;3826.732128750961;3835.424686297022;3841.5774264830848;4327.502337231196;4337.527609262753;4348.434703488526;4350.195213885441;4351.608355248043;4752.334673145762;5082.33929589151;5087.618428617869;5087.694738315713;5096.541311282002;1268.809678548225;1299.7595444842734;1300.0834411739702;1300.4668086084848;1301.3948513941064;807.6769292283134;831.1439217605875;841.7247869477746;842.5871323051783;844.3329769482041;4009.578994205625;4066.34938409853;4082.857100001486;4122.237386083584;4134.689898257643;4542.727436353829;4565.520620334817;4616.676832621684;4642.187617166982;4659.347691323217;3978.980105099456;3981.5620281768984;4005.5593884673244;4028.5568587455355;4067.633912947849;2281.4752606900506;2447.6940382452194;2465.815063870217;2471.9258422247362;2479.9876000620243;4696.671233013656;4775.331453596499;4976.253561965662;4977.875553111201;4998.1756658819995;5386.973065134727;5389.326334208224;5389.380221274525;5398.1093119634825;5413.729313534308;4776.331313616027;4954.504549545017;4973.104841128559;5005.174146265826;5005.7997680092385;5179.30079439286;5188.818391356284;5189.481051894781;5205.8026653869065;5211.4105197915;5139.14990603375;5158.38099428071;5180.171172612364;5189.273501709688;5194.8961020778615;4804.495527969652;4963.70217786934;4977;4991.302956994639;4993.126202914403;3641.5266015417824;3696.3716168250926;3697.8890633281044;3707.666310032002;3723.515942927402;5266.8419947401635;5277.20841873722;5286.497782710637;5288.5985213917575;5294.8941021180135;4927.203898273204;4949.307097006494;5051.419086805065;5142.897142057063;5148.764296568722;4963.528464795983;4989.201727723546;4999.450060493416;5011.624128190328;5014.297998280316;4933;4955.35580374549;4957.182064959241;4957.231629097496;4965.528274813887;4889.755512224303;4997.075541024922;5063;5066.36670416198;5095.974520127375;4879.658423910292;4901.3383193268455;4907.9263811043575;4941.036497883022;4952.281919121635 19:18:27 INFO - PROCESS | 2270 | |5;yui.html;605.772835186805;665.0157766505572;669.9263081061082;686.406258586323;724.2467833453208;11539.134564907634;11815.23200991935;11838.7632247355;11949.34278614677;12009.579664711726;13035.73928521429;13206;13207.933960330209;13218;13230.338483075855;604.350323402342;737.222230546773;744.3226663736001;764.2853931573968;766.6205228411916;768.1703759939252;771.8649236383638;772.2740623813597;772.8686123359042;772.9884051739228;818.059231883336;820.2658620534618;820.3396266005863;820.979475513111;821.3347188777079;646.5054233511391;665.8801415745164;667.5961043568668;668.6589839182052;818.7461886815076;571.8170185540629;583.8540364908773;586.5424968524558;590.5334785519434;591.2254946020727;11618.477168527437;11622.535098596047;11634.243774154653;11639.825402618968;11644.825327620092;11817.881821181763;12390.5663301784;12488.937555312255;12606.117571769979;13085.214887106804;9358.15776580111;9386.061393860628;9547.665831695856;9568.043195680377;11498.42507874603;4028.295048366524;4034.899127521806;4037.212743515016;4053.574374690674;4097.8770636880945;53099.734501327635;53284;53408;53431.465685343035;53496.73251633717;10004.54979525923;10042.19662427004;10139;10250.64122755715;10256.794864102825;17759.911200443916;18924.90537547331;18954.241830326908;19054.951207806684;19089.331873384366;6502.3744063984;6542.738290468423;6563.048357988065;6939.063226464464;7116;3485.5294535237927;3573.7498375114014;3596.3526565218513;3635.163912300133;3703.777773333609;2836.4185342005253;2955.2907302247736;2963.09625564205;2966.391889662614;2971.9702802972124;516.4370835789008;522.0159998403037;531.1395539226478;533.4318950317898;559.3651205881354;449.1600706678467;480.1645137460863;484.5759960034969;557.6486813307671;579.0070029898744;7402.518836275625;7468.626568671653;7854.136045035041;8182.836343273101;8237.135100814448;510.341659259551;511.18721233238585;542.6120323968303;546.4562760053772;561.6349372907642;3515.9607427691876;3602.1354874829854;3697.574778900407;3743.4384842273876;3794.5256842894637;58212;79243.20756792474;103236.64396916333;104264.47867760612;106811;89321;90397.96020398039;90512;91728;91770;46288.53711462909;57978;74450.25549744541;76937.23062769524;78556;7151.177614574182;7375.594342311009;7413.443991700537;8420.410571259952;8458.196471335214;30882.845585771927;38498.80750596229;42022.36966445445;42971.140577188904;43903.34144987764;41896.16207675768;53394;54188.600766881194;58015.70992145012;59972.700136499036;10849.837252441062;11053.668389948314;11186.105111591216;11241.213115081866;11392;12168.87831121713;12492.812607810709;12632.873671263169;12984.220946742847;13108.016898732443;10325.793484130425;10481.842772358268;11508.88491115078;11944.820827687765;11948.641540753792;11091.889081109408;11671.343083455282;11880.881191187977;12323.568675096329;12822.358882056047;11497.252678575866;12127.696807579881;12137.757244855231;12258.632241032783;12283.324417157142;9558.23534117255;10162.898371016196;10392.22058345612;10706.785864282827;10821;9104.180623743894;9371.906280937375;10163.186945044527;10170.796584068425;10207.733525272139 19:18:27 INFO - PROCESS | 2270 | __end_tp_report 19:18:27 INFO - PROCESS | 2270 | __start_cc_report 19:18:27 INFO - PROCESS | 2270 | _x_x_mozilla_cycle_collect,995 19:18:27 INFO - PROCESS | 2270 | __end_cc_report 19:18:27 INFO - PROCESS | 2270 | __startTimestamp1472782707487__endTimestamp 19:18:27 INFO - PROCESS | 2270 | 19:18:27 INFO - PROCESS | 2270 | ------- Summary: start ------- 19:18:27 INFO - PROCESS | 2270 | Number of tests: 6 19:18:27 INFO - PROCESS | 2270 | 19:18:27 INFO - PROCESS | 2270 | [#0] dojo.html Cycles:165 Average:4719.85 Median:4845.08 stddev:489.37 (10.1%) stddev-sans-first:462.01 19:18:27 INFO - PROCESS | 2270 | Values: 2609.0 2627.2 2629.9 2685.0 2691.6 4575.2 4624.9 4696.7 4769.1 4837.1 4624.4 4649.8 4667.8 4675.9 4709.8 4374.6 4391.5 4473.7 4476.8 4495.2 4412.3 4450.6 4450.6 4474.2 4486.2 4381.4 4568.0 4570.5 4571.2 4577.4 4276.7 4396.6 4401.8 4434.5 4466.1 4258.9 4279.6 4291.8 4307.4 4323.8 4659.9 4671.4 4673.7 4754.8 4801.1 5037.4 5075.3 5086.3 5089.3 5142.6 4970.1 5113.0 5164.9 5173.7 5179.9 4781.5 4789.9 4803.7 4805.0 4811.9 5055.9 5310.0 5311.8 5318.0 5360.4 4966.4 5012.5 5017.1 5019.1 5104.2 5116.5 5134.8 5135.2 5136.5 5195.5 4925.6 5091.8 5092.4 5098.6 5103.0 4975.6 5043.8 5047.6 5048.6 5050.2 4323.0 4346.1 4359.7 4361.2 4362.5 3775.8 3838.2 3839.7 3853.8 3874.0 4430.7 4438.6 4440.1 4440.4 4496.6 4957.1 5136.2 5140.3 5146.7 5202.3 4405.7 4411.0 4437.7 4440.7 4501.6 4607.9 4615.5 4615.6 4619.1 4674.3 4644.6 4800.4 4859.7 4864.1 4920.2 5085.3 5107.4 5126.6 5129.3 5179.2 4838.4 4845.1 4849.7 4849.9 4901.0 4813.2 5037.8 5047.4 5050.1 5108.2 5073.1 5081.0 5121.4 5121.5 5159.9 4969.4 4979.7 4990.9 4997.9 5046.9 4731.0 4970.9 4983.3 4990.6 5053.9 4816.7 4862.0 4863.3 4868.0 4898.5 4953.8 4964.8 4966.2 4978.0 5019.3 4806.5 4850.7 4858.7 4863.3 4863.5 19:18:27 INFO - PROCESS | 2270 | 19:18:27 INFO - PROCESS | 2270 | [#1] ext.html Cycles:180 Average:46105.86 Median:34848.56 stddev:87046.70 (249.8%) stddev-sans-first:87223.74 19:18:27 INFO - PROCESS | 2270 | Values: 568.2 568.8 572.8 581.1 583.2 28045.3 37208.6 38696.4 38714.2 42470.4 40016.2 40269.8 40329.4 40336.4 40442.8 7776.2 7927.5 7935.6 7936.1 7937.2 7738.8 7816.2 7820.1 7826.4 7827.3 7825.6 7892.3 7892.5 7904.8 7908.8 7816.2 7862.7 7866.4 7867.3 7869.2 7747.0 7821.5 7822.9 7831.8 7834.2 38211.6 38510.2 38514.4 38558.0 38633.8 2772.2 2808.4 2936.8 3207.2 3404.5 27976.9 28557.6 28589.3 28782.6 29964.0 3492.1 3535.1 3539.9 3599.6 3622.8 239087.0 239479.0 239585.0 239632.0 240321.0 31668.8 32351.8 50995.5 51229.0 51274.5 31862.9 32169.2 32170.2 32181.4 32184.0 12232.6 12303.4 12304.1 12314.9 12315.0 10171.7 10217.2 10252.2 10283.7 10303.3 7592.4 7686.1 7712.6 7714.7 7741.1 3029.5 3064.2 3074.2 3120.2 3150.6 808.9 842.8 875.9 973.8 1016.4 29055.0 31601.0 31762.7 31783.8 32225.8 909.4 930.2 934.5 965.8 1015.1 13860.7 14610.3 14724.4 14972.0 15178.8 397039.0 400029.0 400409.0 400511.0 401801.0 48022.8 48570.0 48590.3 48715.3 48755.8 1043.6 1160.8 1179.0 1179.1 1195.2 27540.2 28524.9 29122.3 29401.6 29610.1 41126.0 42050.8 42068.0 42112.8 42147.2 326201.0 328863.0 328933.0 329067.0 329380.0 21723.7 23574.9 23728.5 23970.9 24416.9 39714.4 40090.6 40110.2 40159.2 40852.0 34318.7 34675.8 34802.3 35005.0 35695.8 34405.0 34589.0 34751.7 34894.8 35275.8 33403.8 33785.7 34514.7 34566.5 34778.3 30188.7 31604.0 31668.7 31709.2 31972.5 24201.0 24445.4 24687.6 24833.4 24844.6 19:18:27 INFO - PROCESS | 2270 | 19:18:27 INFO - PROCESS | 2270 | [#2] jquery.html Cycles:180 Average:21987.49 Median:4663.43 stddev:54839.15 (1175.9%) stddev-sans-first:54968.92 19:18:27 INFO - PROCESS | 2270 | Values: 348.6 365.2 376.9 379.9 387.4 12225.9 13703.1 16287.9 16403.3 16417.2 15964.4 16320.7 16415.0 16464.5 16470.5 4337.5 4526.4 4591.1 4655.0 4680.4 3478.8 3562.1 4629.7 4671.9 4680.4 3682.4 3742.8 5938.7 5977.5 6052.7 5815.2 6050.8 6062.4 6065.8 6067.9 5304.8 5321.2 5339.8 5345.0 5348.2 12386.6 12458.8 12672.2 12676.2 12789.4 1786.8 1799.7 1891.8 2262.7 2371.6 8999.6 10350.6 12850.4 13100.0 13580.1 1662.2 1668.6 1674.0 1695.7 1707.7 47101.5 65303.7 72959.3 73702.0 74510.0 10041.0 10122.5 10153.3 10254.9 10410.5 13986.9 14000.2 14004.4 14009.7 14011.2 7107.5 7199.0 7411.5 7449.0 7472.2 6831.2 6881.4 6881.5 7043.0 7059.4 4308.8 4319.9 4383.8 4415.2 4466.9 1794.6 1806.8 1857.6 1886.2 1895.8 755.7 907.3 912.6 915.2 916.7 16389.6 16407.8 16577.9 17031.7 17453.1 828.2 877.4 884.9 886.7 889.9 9134.0 9156.5 9728.0 9848.8 9955.4 290802.0 293633.0 294790.0 376928.0 378629.0 49615.5 58155.0 80143.6 81923.0 85695.0 880.6 893.4 928.2 929.2 933.1 14489.3 15486.9 15791.3 16300.6 16488.8 37719.0 38893.8 39053.6 39439.2 41643.6 45717.1 48274.5 51663.5 52230.2 52325.2 6955.9 7117.5 7232.4 7416.4 7608.2 10020.5 10852.0 11057.4 11151.8 11336.8 9492.0 9642.9 9679.9 9829.4 10050.3 8835.7 9328.2 9542.6 9564.3 9858.8 8734.5 9053.0 9250.6 9295.7 10055.1 7126.9 7212.5 7352.6 7416.3 7649.5 7325.0 9198.4 9323.3 9570.6 9872.3 19:18:27 INFO - PROCESS | 2270 | 19:18:27 INFO - PROCESS | 2270 | [#3] mootools.html Cycles:180 Average:5059.94 Median:4847.77 stddev:2898.93 (59.8%) stddev-sans-first:2892.67 19:18:27 INFO - PROCESS | 2270 | Values: 1216.6 1303.2 1376.6 1415.3 1704.8 7607.9 7936.8 8010.9 8197.8 8212.1 8008.8 8116.4 8128.5 8131.3 8134.6 2208.2 2228.6 2231.4 2233.6 2234.5 2170.6 2200.8 2203.8 2207.6 2208.8 2193.7 2195.8 2207.2 2207.3 2237.9 2144.3 2144.9 2148.3 2149.0 2150.5 2105.8 2140.3 2141.6 2142.8 2144.3 7852.9 8081.5 8121.8 8131.3 8138.2 4451.9 4557.9 4571.1 4578.5 4589.7 2813.4 2893.3 2929.8 2934.7 2944.3 915.1 917.1 920.0 927.4 943.8 10870.4 10964.9 10965.3 10968.6 10973.6 3909.3 4083.2 4192.3 4238.5 4241.2 8094.8 8095.3 8100.3 8107.6 8112.3 4414.7 4418.5 4420.9 4422.4 4427.4 3521.9 3944.3 4089.4 4095.9 4104.2 3339.4 3348.2 3452.6 3462.6 3515.4 1017.9 1041.3 1042.3 1048.8 1063.1 659.4 766.4 773.6 795.1 808.4 4886.3 4975.0 4980.8 5056.4 5134.2 396.6 403.2 412.1 413.9 414.0 3444.7 3499.8 3523.4 3523.6 3675.8 9083.8 9383.5 9467.8 9481.3 9496.3 9449.7 9476.4 9523.8 9527.2 9531.4 7228.6 7236.2 7254.8 7259.4 7280.6 4791.8 4831.3 4904.6 4949.8 5112.8 8829.1 8837.2 8864.9 8886.6 8889.7 8859.9 8930.6 8933.2 8962.3 9064.0 5566.6 6096.2 6154.7 6156.8 6215.7 7722.4 7737.3 7737.5 7764.0 7779.8 6735.2 6776.0 6789.6 6801.7 6926.8 6729.1 6748.1 6859.7 6909.1 6946.6 6143.9 6226.9 6236.9 6239.7 6239.7 4238.3 4331.3 4411.6 4434.0 4479.3 4522.1 4587.4 4690.7 4714.4 4864.3 19:18:27 INFO - PROCESS | 2270 | 19:18:27 INFO - PROCESS | 2270 | [#4] prototype.html Cycles:180 Average:4172.90 Median:4730.57 stddev:1217.86 (25.7%) stddev-sans-first:1186.07 19:18:27 INFO - PROCESS | 2270 | Values: 299.6 305.6 312.1 312.5 316.4 4814.1 4852.3 4860.7 4872.5 4893.8 4777.0 4798.4 4848.6 4862.7 4871.6 3847.5 3854.8 3861.7 3889.8 3907.9 3773.2 3838.3 3851.6 3891.4 3905.8 3788.0 3816.8 3839.6 3852.6 3859.0 3795.4 3795.4 3804.3 3807.3 3815.2 3166.9 3277.7 3389.7 3406.0 3428.1 4680.3 4688.6 4696.1 4702.2 4708.8 4355.8 4393.5 4395.5 4401.5 4404.3 4780.8 4797.9 4834.4 4937.4 5036.0 3658.5 3670.2 3670.9 3683.0 3693.1 5239.5 5248.9 5249.9 5254.2 5299.8 3685.2 3720.4 3736.4 3756.6 3796.9 3820.8 3824.0 3826.7 3835.4 3841.6 4327.5 4337.5 4348.4 4350.2 4351.6 4752.3 5082.3 5087.6 5087.7 5096.5 1268.8 1299.8 1300.1 1300.5 1301.4 807.7 831.1 841.7 842.6 844.3 4009.6 4066.3 4082.9 4122.2 4134.7 4542.7 4565.5 4616.7 4642.2 4659.3 3979.0 3981.6 4005.6 4028.6 4067.6 2281.5 2447.7 2465.8 2471.9 2480.0 4696.7 4775.3 4976.3 4977.9 4998.2 5387.0 5389.3 5389.4 5398.1 5413.7 4776.3 4954.5 4973.1 5005.2 5005.8 5179.3 5188.8 5189.5 5205.8 5211.4 5139.1 5158.4 5180.2 5189.3 5194.9 4804.5 4963.7 4977.0 4991.3 4993.1 3641.5 3696.4 3697.9 3707.7 3723.5 5266.8 5277.2 5286.5 5288.6 5294.9 4927.2 4949.3 5051.4 5142.9 5148.8 4963.5 4989.2 4999.5 5011.6 5014.3 4933.0 4955.4 4957.2 4957.2 4965.5 4889.8 4997.1 5063.0 5066.4 5096.0 4879.7 4901.3 4907.9 4941.0 4952.3 19:18:27 INFO - PROCESS | 2270 | 19:18:27 INFO - PROCESS | 2270 | [#5] yui.html Cycles:180 Average:16776.68 Median:43437.24 stddev:24149.34 (55.6%) stddev-sans-first:24186.56 19:18:27 INFO - PROCESS | 2270 | Values: 605.8 665.0 669.9 686.4 724.2 11539.1 11815.2 11838.8 11949.3 12009.6 13035.7 13206.0 13207.9 13218.0 13230.3 604.4 737.2 744.3 764.3 766.6 768.2 771.9 772.3 772.9 773.0 818.1 820.3 820.3 821.0 821.3 646.5 665.9 667.6 668.7 818.7 571.8 583.9 586.5 590.5 591.2 11618.5 11622.5 11634.2 11639.8 11644.8 11817.9 12390.6 12488.9 12606.1 13085.2 9358.2 9386.1 9547.7 9568.0 11498.4 4028.3 4034.9 4037.2 4053.6 4097.9 53099.7 53284.0 53408.0 53431.5 53496.7 10004.5 10042.2 10139.0 10250.6 10256.8 17759.9 18924.9 18954.2 19055.0 19089.3 6502.4 6542.7 6563.0 6939.1 7116.0 3485.5 3573.7 3596.4 3635.2 3703.8 2836.4 2955.3 2963.1 2966.4 2972.0 516.4 522.0 531.1 533.4 559.4 449.2 480.2 484.6 557.6 579.0 7402.5 7468.6 7854.1 8182.8 8237.1 510.3 511.2 542.6 546.5 561.6 3516.0 3602.1 3697.6 3743.4 3794.5 58212.0 79243.2 103236.6 104264.5 106811.0 89321.0 90398.0 90512.0 91728.0 91770.0 46288.5 57978.0 74450.3 76937.2 78556.0 7151.2 7375.6 7413.4 8420.4 8458.2 30882.8 38498.8 42022.4 42971.1 43903.3 41896.2 53394.0 54188.6 58015.7 59972.7 10849.8 11053.7 11186.1 11241.2 11392.0 12168.9 12492.8 12632.9 12984.2 13108.0 10325.8 10481.8 11508.9 11944.8 11948.6 11091.9 11671.3 11880.9 12323.6 12822.4 11497.3 12127.7 12137.8 12258.6 12283.3 9558.2 10162.9 10392.2 10706.8 10821.0 9104.2 9371.9 10163.2 10170.8 10207.7 19:18:27 INFO - PROCESS | 2270 | -------- Summary: end -------- 19:18:27 INFO - PROCESS | 2270 | 19:18:28 INFO - TEST-INFO | 2270: exit 0 19:18:28 INFO - TEST-OK | dromaeo_css | took 1121143ms 19:18:28 INFO - TEST-START | kraken 19:18:28 INFO - operating with platform_type : linux_ 19:18:28 INFO - Initialising browser for kraken test... 19:18:28 INFO - TEST-INFO | started process 2668 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvwUdvF/profile http://localhost:56456/getInfo.html) 19:18:32 INFO - PROCESS | 2668 | __metrics Screen width/height:1600/1200 19:18:32 INFO - PROCESS | 2668 | colorDepth:24 19:18:32 INFO - PROCESS | 2668 | Browser inner width/height: 1024/697 19:18:32 INFO - PROCESS | 2668 | __metrics 19:18:33 INFO - PROCESS | 2668 | 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" 19:18:33 INFO - PROCESS | 2668 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:18:33 INFO - PROCESS | 2668 | console.error: PushService: 19:18:33 INFO - PROCESS | 2668 | stateChangeProcessEnqueue: Error transitioning state 19:18:33 INFO - PROCESS | 2668 | UnknownError 19:18:34 INFO - TEST-INFO | 2668: exit 0 19:18:34 INFO - Browser initialized. 19:18:34 INFO - Running cycle 1/1 for kraken test... 19:18:34 INFO - TEST-INFO | started process 2802 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvwUdvF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:18:46 INFO - PROCESS | 2802 | RSS: Main: 180899840 19:18:46 INFO - PROCESS | 2802 | 19:18:49 INFO - PROCESS | 2802 | Cycle 1(1): loaded http://localhost:56456/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56456/tests/kraken/driver.html?testName=audio-beat-detection) 19:18:50 INFO - PROCESS | 2802 | RSS: Main: 235065344 19:18:50 INFO - PROCESS | 2802 | 19:18:53 INFO - PROCESS | 2802 | Cycle 1(1): loaded http://localhost:56456/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56456/tests/kraken/driver.html?testName=audio-dft) 19:18:53 INFO - PROCESS | 2802 | RSS: Main: 223457280 19:18:53 INFO - PROCESS | 2802 | 19:18:57 INFO - PROCESS | 2802 | Cycle 1(1): loaded http://localhost:56456/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56456/tests/kraken/driver.html?testName=audio-fft) 19:18:57 INFO - PROCESS | 2802 | RSS: Main: 302297088 19:18:57 INFO - PROCESS | 2802 | 19:18:59 INFO - PROCESS | 2802 | Cycle 1(1): loaded http://localhost:56456/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56456/tests/kraken/driver.html?testName=audio-oscillator) 19:19:00 INFO - PROCESS | 2802 | RSS: Main: 212525056 19:19:00 INFO - PROCESS | 2802 | 19:19:02 INFO - PROCESS | 2802 | Cycle 1(1): loaded http://localhost:56456/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56456/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:19:03 INFO - PROCESS | 2802 | RSS: Main: 214540288 19:19:03 INFO - PROCESS | 2802 | 19:19:06 INFO - PROCESS | 2802 | Cycle 1(1): loaded http://localhost:56456/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56456/tests/kraken/driver.html?testName=imaging-darkroom) 19:19:07 INFO - PROCESS | 2802 | RSS: Main: 253415424 19:19:07 INFO - PROCESS | 2802 | 19:19:10 INFO - PROCESS | 2802 | Cycle 1(1): loaded http://localhost:56456/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56456/tests/kraken/driver.html?testName=imaging-desaturate) 19:19:11 INFO - PROCESS | 2802 | RSS: Main: 247275520 19:19:11 INFO - PROCESS | 2802 | 19:19:14 INFO - PROCESS | 2802 | Cycle 1(1): loaded http://localhost:56456/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56456/tests/kraken/driver.html?testName=json-parse-financial) 19:19:14 INFO - PROCESS | 2802 | RSS: Main: 250798080 19:19:14 INFO - PROCESS | 2802 | 19:19:16 INFO - PROCESS | 2802 | Cycle 1(1): loaded http://localhost:56456/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56456/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:19:17 INFO - PROCESS | 2802 | RSS: Main: 214462464 19:19:17 INFO - PROCESS | 2802 | 19:19:18 INFO - PROCESS | 2802 | Cycle 1(1): loaded http://localhost:56456/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56456/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:19:19 INFO - PROCESS | 2802 | RSS: Main: 221515776 19:19:19 INFO - PROCESS | 2802 | 19:19:21 INFO - PROCESS | 2802 | Cycle 1(1): loaded http://localhost:56456/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56456/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:19:22 INFO - PROCESS | 2802 | RSS: Main: 222842880 19:19:22 INFO - PROCESS | 2802 | 19:19:25 INFO - PROCESS | 2802 | Cycle 1(1): loaded http://localhost:56456/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56456/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:19:25 INFO - PROCESS | 2802 | RSS: Main: 224378880 19:19:25 INFO - PROCESS | 2802 | 19:19:28 INFO - PROCESS | 2802 | Cycle 1(1): loaded http://localhost:56456/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56456/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:19:29 INFO - PROCESS | 2802 | RSS: Main: 222621696 19:19:29 INFO - PROCESS | 2802 | 19:19:31 INFO - PROCESS | 2802 | Cycle 1(1): loaded http://localhost:56456/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56456/tests/kraken/driver.html?testName=ai-astar) 19:19:31 INFO - PROCESS | 2802 | RSS: Main: 273625088 19:19:31 INFO - PROCESS | 2802 | 19:19:31 INFO - PROCESS | 2802 | __start_tp_report 19:19:31 INFO - PROCESS | 2802 | _x_x_mozilla_page_load 19:19:31 INFO - PROCESS | 2802 | _x_x_mozilla_page_load_details 19:19:31 INFO - PROCESS | 2802 | |i|pagename|runs| 19:19:31 INFO - PROCESS | 2802 | |0;ai-astar;113;115;120;114;117;113;114;113;113;130 19:19:31 INFO - PROCESS | 2802 | |1;audio-beat-detection;155;124;149;177;124;148;144;130;187;123 19:19:31 INFO - PROCESS | 2802 | |2;audio-dft;162;163;162;160;163;160;162;162;162;161 19:19:31 INFO - PROCESS | 2802 | |3;audio-fft;76;77;76;165;76;76;76;74;157;77 19:19:31 INFO - PROCESS | 2802 | |4;audio-oscillator;83;83;160;84;84;85;153;84;83;142 19:19:31 INFO - PROCESS | 2802 | |5;imaging-gaussian-blur;117;118;118;117;118;117;117;119;117;118 19:19:31 INFO - PROCESS | 2802 | |6;imaging-darkroom;146;146;150;146;146;146;146;145;145;147 19:19:31 INFO - PROCESS | 2802 | |7;imaging-desaturate;95;94;95;95;95;95;95;95;95;95 19:19:31 INFO - PROCESS | 2802 | |8;json-parse-financial;64;64;65;66;65;69;66;66;67;65 19:19:31 INFO - PROCESS | 2802 | |9;json-stringify-tinderbox;65;65;66;67;67;66;66;66;66;66 19:19:31 INFO - PROCESS | 2802 | |10;stanford-crypto-aes;89;83;82;91;89;85;88;81;85;82 19:19:31 INFO - PROCESS | 2802 | |11;stanford-crypto-ccm;135;131;131;135;135;134;135;133;180;143 19:19:31 INFO - PROCESS | 2802 | |12;stanford-crypto-pbkdf2;174;176;174;181;174;174;173;179;172;172 19:19:31 INFO - PROCESS | 2802 | |13;stanford-crypto-sha256-iterative;73;69;69;71;70;70;74;72;69;69 19:19:31 INFO - PROCESS | 2802 | __end_tp_report 19:19:31 INFO - PROCESS | 2802 | __start_cc_report 19:19:31 INFO - PROCESS | 2802 | _x_x_mozilla_cycle_collect,1956 19:19:31 INFO - PROCESS | 2802 | __end_cc_report 19:19:31 INFO - PROCESS | 2802 | __startTimestamp1472782771501__endTimestamp 19:19:31 INFO - PROCESS | 2802 | 19:19:31 INFO - PROCESS | 2802 | ------- Summary: start ------- 19:19:31 INFO - PROCESS | 2802 | Number of tests: 14 19:19:31 INFO - PROCESS | 2802 | 19:19:31 INFO - PROCESS | 2802 | [#0] ai-astar Cycles:10 Average:116.20 Median:114.50 stddev:5.35 (4.7%) stddev-sans-first:5.55 19:19:31 INFO - PROCESS | 2802 | Values: 113.0 115.0 120.0 114.0 117.0 113.0 114.0 113.0 113.0 130.0 19:19:31 INFO - PROCESS | 2802 | 19:19:31 INFO - PROCESS | 2802 | [#1] audio-beat-detection Cycles:10 Average:146.10 Median:148.50 stddev:22.34 (15.0%) stddev-sans-first:23.47 19:19:31 INFO - PROCESS | 2802 | Values: 155.0 124.0 149.0 177.0 124.0 148.0 144.0 130.0 187.0 123.0 19:19:31 INFO - PROCESS | 2802 | 19:19:31 INFO - PROCESS | 2802 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.06 (0.7%) stddev-sans-first:1.12 19:19:31 INFO - PROCESS | 2802 | Values: 162.0 163.0 162.0 160.0 163.0 160.0 162.0 162.0 162.0 161.0 19:19:31 INFO - PROCESS | 2802 | 19:19:31 INFO - PROCESS | 2802 | [#3] audio-fft Cycles:10 Average:93.00 Median:76.00 stddev:35.90 (47.2%) stddev-sans-first:37.54 19:19:31 INFO - PROCESS | 2802 | Values: 76.0 77.0 76.0 165.0 76.0 76.0 76.0 74.0 157.0 77.0 19:19:31 INFO - PROCESS | 2802 | 19:19:31 INFO - PROCESS | 2802 | [#4] audio-oscillator Cycles:10 Average:104.10 Median:83.50 stddev:33.11 (39.6%) stddev-sans-first:34.22 19:19:31 INFO - PROCESS | 2802 | Values: 83.0 83.0 160.0 84.0 84.0 85.0 153.0 84.0 83.0 142.0 19:19:31 INFO - PROCESS | 2802 | 19:19:31 INFO - PROCESS | 2802 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 19:19:31 INFO - PROCESS | 2802 | Values: 117.0 118.0 118.0 117.0 118.0 117.0 117.0 119.0 117.0 118.0 19:19:31 INFO - PROCESS | 2802 | 19:19:31 INFO - PROCESS | 2802 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:1.42 (1.0%) stddev-sans-first:1.50 19:19:31 INFO - PROCESS | 2802 | Values: 146.0 146.0 150.0 146.0 146.0 146.0 146.0 145.0 145.0 147.0 19:19:31 INFO - PROCESS | 2802 | 19:19:31 INFO - PROCESS | 2802 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 19:19:31 INFO - PROCESS | 2802 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 19:19:31 INFO - PROCESS | 2802 | 19:19:31 INFO - PROCESS | 2802 | [#8] json-parse-financial Cycles:10 Average:65.70 Median:66.00 stddev:1.49 (2.3%) stddev-sans-first:1.45 19:19:31 INFO - PROCESS | 2802 | Values: 64.0 64.0 65.0 66.0 65.0 69.0 66.0 66.0 67.0 65.0 19:19:31 INFO - PROCESS | 2802 | 19:19:31 INFO - PROCESS | 2802 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 19:19:31 INFO - PROCESS | 2802 | Values: 65.0 65.0 66.0 67.0 67.0 66.0 66.0 66.0 66.0 66.0 19:19:31 INFO - PROCESS | 2802 | 19:19:31 INFO - PROCESS | 2802 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:86.50 stddev:3.54 (4.1%) stddev-sans-first:3.52 19:19:31 INFO - PROCESS | 2802 | Values: 89.0 83.0 82.0 91.0 89.0 85.0 88.0 81.0 85.0 82.0 19:19:31 INFO - PROCESS | 2802 | 19:19:31 INFO - PROCESS | 2802 | [#11] stanford-crypto-ccm Cycles:10 Average:139.20 Median:135.00 stddev:14.72 (10.9%) stddev-sans-first:15.53 19:19:31 INFO - PROCESS | 2802 | Values: 135.0 131.0 131.0 135.0 135.0 134.0 135.0 133.0 180.0 143.0 19:19:31 INFO - PROCESS | 2802 | 19:19:31 INFO - PROCESS | 2802 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.90 Median:174.00 stddev:2.96 (1.7%) stddev-sans-first:3.12 19:19:31 INFO - PROCESS | 2802 | Values: 174.0 176.0 174.0 181.0 174.0 174.0 173.0 179.0 172.0 172.0 19:19:31 INFO - PROCESS | 2802 | 19:19:31 INFO - PROCESS | 2802 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:70.50 stddev:1.84 (2.6%) stddev-sans-first:1.73 19:19:31 INFO - PROCESS | 2802 | Values: 73.0 69.0 69.0 71.0 70.0 70.0 74.0 72.0 69.0 69.0 19:19:31 INFO - PROCESS | 2802 | -------- Summary: end -------- 19:19:31 INFO - PROCESS | 2802 | 19:19:32 INFO - TEST-INFO | 2802: exit 0 19:19:32 INFO - TEST-OK | kraken | took 64336ms 19:19:32 INFO - SUITE-END | took 1185s 19:19:33 INFO - Completed test suite (00:19:45) 19:19:33 INFO - javascript benchmark 19:19:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2609.034657176845, 2627.19870439516, 2629.88165532551, 2685.0065475773954, 2691.5962605609157, 4575.199340115483, 4624.930626040604, 4696.7416792076465, 4769.070031343885, 4837.105135549921, 4624.445066592005, 4649.837255696051, 4667.813287468505, 4675.929861052078, 4709.788059537321, 4374.562543745624, 4391.451068616423, 4473.686841921067, 4476.753778542179, 4495.190865644183, 4412.338149277602, 4450.621697155746, 4450.643948484129, 4474.23937930551, 4486.170058539181, 4381.3647021181905, 4567.977160114211, 4570.4972453030305, 4571.2000399929875, 4577.359169716243, 4276.700630955835, 4396.582324679166, 4401.801918913625, 4434.467863856358, 4466.084452687224, 4258.872233832959, 4279.572042795696, 4291.828326866922, 4307.396964424983, 4323.805428755682, 4659.860204193846, 4671.369365135731, 4673.672842900998, 4754.833580824655, 4801.087793319293, 5037.4458809530925, 5075.314832497603, 5086.262491938685, 5089.312942752718, 5142.562882155022, 4970.105381031413, 5112.974435127838, 5164.948350516484, 5173.663711858717, 5179.870503237412, 4781.545753153445, 4789.9042019160115, 4803.711777293303, 4805.038992201574, 4811.855644330711, 5055.87360315995, 5310.044192045391, 5311.787528498817, 5318.0, 5360.437154098841, 4966.354373931365, 5012.498750125032, 5017.122003649347, 5019.0965626187635, 5104.157813960729, 5116.488351164854, 5134.794608215704, 5135.204043373283, 5136.512031357015, 5195.506426889439, 4925.581325587294, 5091.821786237464, 5092.439831618519, 5098.617603679739, 5102.974485127551, 4975.577075948585, 5043.84868453947, 5047.621428392885, 5048.646594738333, 5050.166722490748, 4323.048929235563, 4346.087321662423, 4359.738415695068, 4361.171377438277, 4362.498312694017, 3775.7923314217983, 3838.1747924196434, 3839.731218814712, 3853.824583502059, 3874.0121269076203, 4430.689851710414, 4438.578335058164, 4440.111977604492, 4440.422745043188, 4496.595306422438, 4957.132501812169, 5136.178211486144, 5140.254663073833, 5146.691198528026, 5202.323697919246, 4405.669574781904, 4411.0, 4437.733735975852, 4440.71135376206, 4501.639868810487, 4607.9308810367875, 4615.469221039556, 4615.561521655437, 4619.099275641218, 4674.275487299406, 4644.60520855731, 4800.415862765279, 4859.659823812441, 4864.148773964613, 4920.237363208708, 5085.262636917552, 5107.412647545431, 5126.564242039469, 5129.307543481582, 5179.22311653255, 4838.419389673121, 4845.079434907357, 4849.733264670477, 4849.854504364875, 4900.95099049005, 4813.205821039489, 5037.7733002014265, 5047.41954675217, 5050.116229659869, 5108.182690769459, 5073.086844368049, 5081.0, 5121.385433747974, 5121.462246464068, 5159.948400516097, 4969.378827646544, 4979.676321039121, 4990.900181996412, 4997.900041999213, 5046.899062018666, 4730.952690473051, 4970.850874473772, 4983.327250821238, 4990.625703072356, 5053.924191137063, 4816.710997340171, 4862.027594481188, 4863.319135321129, 4868.0, 4898.461169271306, 4953.801847926186, 4964.826231081895, 4966.230234313687, 4977.9751101244265, 5019.297298378157, 4806.47128815837, 4850.733209673502, 4858.659893807399, 4863.294822250825, 4863.465018847854], "value": 4688.804502995568, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.2328856044338, 568.7639629553736, 572.790931310072, 581.1428143488355, 583.1893667801756, 28045.298867528323, 37208.627913720855, 38696.419553706684, 38714.22571548567, 42470.36294455578, 40016.199676006465, 40269.798651006706, 40329.39505907414, 40336.39495407571, 40442.797786011026, 7776.222377762221, 7927.484713493604, 7935.642896069662, 7936.087349954742, 7937.206279372045, 7738.7678369649, 7816.17930117338, 7820.061592608895, 7826.373890088779, 7827.295543401093, 7825.647845846951, 7892.289693927545, 7892.486988345768, 7904.762857114296, 7908.841823163533, 7816.218378162195, 7862.685492580347, 7866.41001924855, 7867.252611001945, 7869.2130786921425, 7746.961265193638, 7821.452498325119, 7822.882656760153, 7831.804204894866, 7834.177411371781, 38211.61788382108, 38510.22979540394, 38514.422283665765, 38558.0, 38633.80683096594, 2772.182206249141, 2808.36811717364, 2936.750376218024, 3207.182168547029, 3404.5403870477417, 27976.860115699496, 28557.57163642547, 28589.28526786847, 28782.568261475884, 29964.0, 3492.1269682579355, 3535.1338921964025, 3539.9115022124397, 3599.5500562429697, 3622.7826330420257, 239087.0, 239479.0, 239585.0, 239631.99999999825, 240321.0, 31668.83311668861, 32351.838240809117, 50995.49004509982, 51229.0, 51274.487255127715, 31862.884799031923, 32169.195770105936, 32170.19574510609, 32181.35637287241, 32184.0, 12232.633021009384, 12303.384830758427, 12304.138710290194, 12314.876851231553, 12315.0, 10171.694849154537, 10217.18262538995, 10252.23108266883, 10283.691489255334, 10303.278770485995, 7592.392608591299, 7686.077670679442, 7712.614369281626, 7714.729984450517, 7741.07107147146, 3029.4546981543535, 3064.2033071401597, 3074.1699741069788, 3120.1731541141617, 3150.57467241924, 808.9069756977905, 842.8314337132598, 875.8861348024843, 973.8149751547184, 1016.415561052383, 29055.0, 31601.0, 31762.682373176434, 31783.84108079445, 32225.838870805495, 909.4361495872469, 930.237205491504, 934.4766930518796, 965.8309795785709, 1015.1067060986433, 13860.653483662989, 14610.269486525844, 14724.411023558938, 14972.0, 15178.772318415233, 397039.0, 400029.0, 400409.0, 400511.0, 401801.0, 48022.75988620034, 48570.0, 48590.27114593284, 48715.26927096096, 48755.75622121867, 1043.5669197283194, 1160.785254727878, 1178.988210117905, 1179.0803173524664, 1195.2231049817688, 27540.173794786187, 28524.85737571299, 29122.27194320159, 29401.558976615797, 29610.111696649135, 41126.0, 42050.789746052295, 42068.0, 42112.789436052626, 42147.15705685808, 326201.0, 328863.0, 328933.0, 329067.0, 329380.0, 21723.674144888155, 23574.88212558926, 23728.52542949166, 23970.88014559916, 24416.877915611018, 39714.40428393634, 40090.599094008685, 40110.19779604333, 40159.19681606293, 40852.0, 34318.65681343254, 34675.826620867745, 34802.30395392027, 35005.0, 35695.82152089223, 34405.0, 34589.0, 34751.65248347585, 34894.825525872206, 35275.82362088173, 33403.83298083591, 33785.66214337923, 34514.654853451146, 34566.48150277697, 34778.30443391169, 30188.69811301859, 31604.0, 31668.683313166573, 31709.20726981844, 31972.520412194302, 24200.961092231555, 24445.38886527851, 24687.5687348783, 24833.379165521008, 24844.627330590418], "value": 16168.8729020813, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.6043340808182, 365.19656755138703, 376.8812823960452, 379.9183175617243, 387.3956627660849, 12225.938870305647, 13703.10929789563, 16287.918560407212, 16403.343866245337, 16417.179141042943, 15964.361425542964, 16320.673586528292, 16415.0, 16464.506064818044, 16470.505884823444, 4337.501187363462, 4526.366308716782, 4591.058832939239, 4655.0, 4680.438347398317, 3478.808665523395, 3562.091666625007, 4629.7222166669935, 4671.85984420468, 4680.4149481314835, 3682.4476328550663, 3742.7941463219513, 5938.703064846762, 5977.521798256151, 6052.727627256762, 5815.214945982323, 6050.789842031567, 6062.363451837559, 6065.7573697052285, 6067.939320606782, 5304.787808487656, 5321.2284218788445, 5339.786408543654, 5345.037893179227, 5348.171033489815, 12386.62840114798, 12458.81311780324, 12672.176308539916, 12676.2394256344, 12789.360531973363, 1786.8391844734037, 1799.703048996914, 1891.8297353238274, 2262.7171603549555, 2371.5731168389684, 8999.640014399416, 10350.58597656093, 12850.357482125857, 13100.0, 13580.117292376062, 1662.1523023258105, 1668.6162182697926, 1673.9748903766454, 1695.6608678264274, 1707.6840784454791, 47101.52898471006, 65303.673481632766, 72959.27040729577, 73702.0, 74510.0, 10041.0, 10122.493875306205, 10153.289269751194, 10254.948725256476, 10410.531526081344, 13986.930065349812, 14000.159990400609, 14004.43982240699, 14009.71980560383, 14011.229382384066, 7107.466939979522, 7198.964005179941, 7411.518251313755, 7448.962755186298, 7472.215417381097, 6831.248562658104, 6881.380675739108, 6881.518293719491, 7043.049188359506, 7059.435245180373, 4308.784560771949, 4319.913601727948, 4383.758893260838, 4415.205263052681, 4466.932996005063, 1794.5603327184663, 1806.8102849200907, 1857.58204404008, 1886.1700851625242, 1895.8198971097725, 755.7014979083341, 907.328576853124, 912.6278401307238, 915.1534830281962, 916.7295647783919, 16389.59026024359, 16407.83592164063, 16577.91711041437, 17031.65936681284, 17453.12734363277, 828.1842385250524, 877.3902138014147, 884.8716936044237, 886.6719313853915, 889.9466032038099, 9134.0, 9156.542172891328, 9727.951360243154, 9848.753781155528, 9955.352902061342, 290802.0, 293633.0, 294790.0, 376928.0, 378629.0, 49615.50384496181, 58155.0, 80143.59928200321, 81923.0, 85695.0, 880.6125304865839, 893.3924931046951, 928.2202949522299, 929.1544694328129, 933.0902370189011, 14489.275536222936, 15486.922565387102, 15791.289391977618, 16300.592485187492, 16488.752668709738, 37719.0, 38893.805530973295, 39053.609463905, 39439.2112157761, 41643.58356416518, 45717.1319702134, 48274.517254827006, 51663.48336516737, 52230.21654675259, 52325.215121772446, 6955.930440695528, 7117.501774875709, 7232.385247254042, 7416.406687465098, 7608.16310205888, 10020.549075291483, 10852.0, 11057.391843448688, 11151.776964460503, 11336.829947550628, 9491.952540237531, 9642.903570964201, 9679.93364843654, 9829.361091529028, 10050.346727462691, 8835.69075082369, 9328.207102396373, 9542.570584323861, 9564.330496865152, 9858.802823943624, 8734.475931444134, 9053.0, 9250.583723732583, 9295.67465138717, 10055.145312648507, 7126.893096603451, 7212.531185472927, 7352.632368381453, 7416.295451932057, 7649.541027538366, 7324.96337518309, 9198.402103863227, 9323.347365684336, 9570.617175313188, 9872.308938374244], "value": 7899.261590768858, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1216.5924415320867, 1303.1855090568395, 1376.6489545165982, 1415.2569900802077, 1704.7698560694303, 7607.885881711772, 7936.801579960504, 8010.91989080109, 8197.795055123624, 8212.055613604438, 8008.799780005503, 8116.350691944645, 8128.471649342789, 8131.308838748713, 8134.593270336489, 2208.1719355241785, 2228.6099932511825, 2231.4421394651336, 2233.564454931289, 2234.4637287051073, 2170.565886822642, 2200.8129309008673, 2203.834712396577, 2207.6467765157577, 2208.8122509586706, 2193.6928829963817, 2195.769444208351, 2207.1612787140944, 2207.3046990198036, 2237.8881055947218, 2144.2923835134447, 2144.871307721526, 2148.3125399872047, 2149.032935179168, 2150.5053837617434, 2105.810477057072, 2140.315099168267, 2141.635921893282, 2142.8071473567297, 2144.3352560706076, 7852.921470785276, 8081.4747041442115, 8121.8223357612815, 8131.349492040623, 8138.226868447488, 4451.866444006685, 4557.931631025537, 4571.062932098945, 4578.542145785428, 4589.678722489427, 2813.3529288263608, 2893.3489964757973, 2929.8095623784598, 2934.7065293470696, 2944.2933695912825, 915.0803442540271, 917.124146440148, 919.9862002069974, 927.3832901120746, 943.8395472769646, 10870.402127882964, 10964.945175274073, 10965.287256328393, 10968.561257549689, 10973.561057557688, 3909.3158697227873, 4083.1833633273463, 4192.266353388206, 4238.491381034296, 4241.172971270573, 8094.757157285291, 8095.311898488694, 8100.270975612106, 8107.554084525408, 8112.310453611509, 4414.741798587387, 4418.491873434532, 4420.889477763018, 4422.380866678667, 4427.424434823517, 3521.8591256349973, 3944.290027794967, 4089.386592011222, 4095.877123686294, 4104.220198162339, 3339.3655205510877, 3348.179695974502, 3452.5684289463816, 3462.6191118976894, 3515.4375299951885, 1017.8829434614966, 1041.250299784154, 1042.3016578892161, 1048.8059708953867, 1063.1335461598771, 659.4197106546209, 766.3907193780846, 773.6131934032984, 795.0816806588284, 808.4219782855287, 4886.29148773433, 4974.950250497521, 4980.751676786968, 5056.443791182967, 5134.152864777345, 396.55189635712037, 403.16544752362915, 412.142743094363, 413.89445691348516, 413.9648129908931, 3444.7244220462303, 3499.7725147865817, 3523.3834079036064, 3523.6300188480354, 3675.7794532328144, 9083.81832363349, 9383.483908385104, 9467.76330591727, 9481.33630645862, 9496.287778416647, 9449.66926157595, 9476.431414115175, 9523.761905952406, 9527.190188834027, 9531.38046027006, 7228.602426866468, 7236.204017558064, 7254.802957511952, 7259.382952449101, 7280.635968201569, 4791.808327666854, 4831.275308703723, 4904.583110435653, 4949.752512374439, 5112.821051263188, 8829.072947340437, 8837.160469755363, 8864.911350886667, 8886.60010299551, 8889.688860889837, 8859.911400886167, 8930.598123084346, 8933.19601235892, 8962.32782541299, 9064.048274931301, 5566.636174137362, 6096.207493025879, 6154.661493617894, 6156.815295541141, 6215.689215539295, 7722.420818438752, 7737.342325902361, 7737.497062691133, 7763.961180194063, 7779.7666070017995, 6735.225449073419, 6775.966120169368, 6789.62657053847, 6801.7279308829075, 6926.792196234121, 6729.125213722381, 6748.089007983859, 6859.657017149222, 6909.1018167637885, 6946.6179360135675, 6143.877122457437, 6226.875462490634, 6236.875262494816, 6239.688015599111, 6239.688015599111, 4238.3430568261965, 4331.306990881444, 4411.602955733999, 4434.0, 4479.260921947973, 4522.118186953644, 4587.357769912148, 4690.718556886462, 4714.4106986626675, 4864.270359446112], "value": 3979.0782171317924, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.5895622996494, 305.56457048705596, 312.10114869176766, 312.48752046643494, 316.39726321357824, 4814.085323788482, 4852.320675105488, 4860.65975381723, 4872.4640289568115, 4893.8287159949405, 4777.0, 4798.424189097304, 4848.587870031043, 4862.683925544837, 4871.5615594596475, 3847.480590120333, 3854.807259637007, 3861.6636934654553, 3889.755278310942, 3907.921841563167, 3773.2264885698505, 3838.309104361214, 3851.614838516154, 3891.416287556861, 3905.7656540607513, 3788.0, 3816.7709937403843, 3839.5584507781546, 3852.5569559500595, 3858.9807050964846, 3795.3737633290475, 3795.3927371620407, 3804.334241507725, 3807.3337165996118, 3815.2369526094753, 3166.9208269793207, 3277.655846136169, 3389.7288216942584, 3406.0, 3428.074419906636, 4680.297955306697, 4688.578027977464, 4696.060787842411, 4702.177119004161, 4708.811647534095, 4355.802154407532, 4393.494748103945, 4395.450568678915, 4401.493828209733, 4404.273294906337, 4780.832670856538, 4797.928031079537, 4834.444038935532, 4937.395346512398, 5035.974820125876, 3658.487811706363, 3670.247599242149, 3670.871519496805, 3682.963170368316, 3693.132113953219, 5239.47605239473, 5248.895022099575, 5249.86875328116, 5254.21186821976, 5299.7810503584005, 3685.244524872395, 3720.404735242348, 3736.393350859102, 3756.6055564165367, 3796.9430458543143, 3820.7707537547835, 3823.9617603824163, 3826.732128750961, 3835.424686297022, 3841.5774264830848, 4327.502337231196, 4337.527609262753, 4348.434703488526, 4350.195213885441, 4351.608355248043, 4752.334673145762, 5082.33929589151, 5087.618428617869, 5087.694738315713, 5096.541311282002, 1268.809678548225, 1299.7595444842734, 1300.0834411739702, 1300.4668086084848, 1301.3948513941064, 807.6769292283134, 831.1439217605875, 841.7247869477746, 842.5871323051783, 844.3329769482041, 4009.578994205625, 4066.34938409853, 4082.857100001486, 4122.237386083584, 4134.689898257643, 4542.727436353829, 4565.520620334817, 4616.676832621684, 4642.187617166982, 4659.347691323217, 3978.980105099456, 3981.5620281768984, 4005.5593884673244, 4028.5568587455355, 4067.633912947849, 2281.4752606900506, 2447.6940382452194, 2465.815063870217, 2471.9258422247362, 2479.9876000620243, 4696.671233013656, 4775.331453596499, 4976.253561965662, 4977.875553111201, 4998.1756658819995, 5386.973065134727, 5389.326334208224, 5389.380221274525, 5398.1093119634825, 5413.729313534308, 4776.331313616027, 4954.504549545017, 4973.104841128559, 5005.174146265826, 5005.7997680092385, 5179.30079439286, 5188.818391356284, 5189.481051894781, 5205.8026653869065, 5211.4105197915, 5139.14990603375, 5158.38099428071, 5180.171172612364, 5189.273501709688, 5194.8961020778615, 4804.495527969652, 4963.70217786934, 4977.0, 4991.302956994639, 4993.126202914403, 3641.5266015417824, 3696.3716168250926, 3697.8890633281044, 3707.666310032002, 3723.515942927402, 5266.8419947401635, 5277.20841873722, 5286.497782710637, 5288.5985213917575, 5294.8941021180135, 4927.203898273204, 4949.307097006494, 5051.419086805065, 5142.897142057063, 5148.764296568722, 4963.528464795983, 4989.201727723546, 4999.450060493416, 5011.624128190328, 5014.297998280316, 4933.0, 4955.35580374549, 4957.182064959241, 4957.231629097496, 4965.528274813887, 4889.755512224303, 4997.075541024922, 5063.0, 5066.36670416198, 5095.974520127375, 4879.658423910292, 4901.3383193268455, 4907.9263811043575, 4941.036497883022, 4952.281919121635], "value": 3787.0824767408585, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.772835186805, 665.0157766505572, 669.9263081061082, 686.406258586323, 724.2467833453208, 11539.134564907634, 11815.23200991935, 11838.7632247355, 11949.34278614677, 12009.579664711726, 13035.73928521429, 13206.0, 13207.933960330209, 13218.0, 13230.338483075855, 604.350323402342, 737.222230546773, 744.3226663736001, 764.2853931573968, 766.6205228411916, 768.1703759939252, 771.8649236383638, 772.2740623813597, 772.8686123359042, 772.9884051739228, 818.059231883336, 820.2658620534618, 820.3396266005863, 820.979475513111, 821.3347188777079, 646.5054233511391, 665.8801415745164, 667.5961043568668, 668.6589839182052, 818.7461886815076, 571.8170185540629, 583.8540364908773, 586.5424968524558, 590.5334785519434, 591.2254946020727, 11618.477168527437, 11622.535098596047, 11634.243774154653, 11639.825402618968, 11644.825327620092, 11817.881821181763, 12390.5663301784, 12488.937555312255, 12606.117571769979, 13085.214887106804, 9358.15776580111, 9386.061393860628, 9547.665831695856, 9568.043195680377, 11498.42507874603, 4028.295048366524, 4034.899127521806, 4037.212743515016, 4053.574374690674, 4097.8770636880945, 53099.734501327635, 53284.0, 53408.0, 53431.465685343035, 53496.73251633717, 10004.54979525923, 10042.19662427004, 10139.0, 10250.64122755715, 10256.794864102825, 17759.911200443916, 18924.90537547331, 18954.241830326908, 19054.951207806684, 19089.331873384366, 6502.3744063984, 6542.738290468423, 6563.048357988065, 6939.063226464464, 7116.0, 3485.5294535237927, 3573.7498375114014, 3596.3526565218513, 3635.163912300133, 3703.777773333609, 2836.4185342005253, 2955.2907302247736, 2963.09625564205, 2966.391889662614, 2971.9702802972124, 516.4370835789008, 522.0159998403037, 531.1395539226478, 533.4318950317898, 559.3651205881354, 449.1600706678467, 480.1645137460863, 484.5759960034969, 557.6486813307671, 579.0070029898744, 7402.518836275625, 7468.626568671653, 7854.136045035041, 8182.836343273101, 8237.135100814448, 510.341659259551, 511.18721233238585, 542.6120323968303, 546.4562760053772, 561.6349372907642, 3515.9607427691876, 3602.1354874829854, 3697.574778900407, 3743.4384842273876, 3794.5256842894637, 58212.0, 79243.20756792474, 103236.64396916333, 104264.47867760612, 106811.0, 89321.0, 90397.96020398039, 90512.0, 91728.0, 91770.0, 46288.53711462909, 57978.0, 74450.25549744541, 76937.23062769524, 78556.0, 7151.177614574182, 7375.594342311009, 7413.443991700537, 8420.410571259952, 8458.196471335214, 30882.845585771927, 38498.80750596229, 42022.36966445445, 42971.140577188904, 43903.34144987764, 41896.16207675768, 53394.0, 54188.600766881194, 58015.70992145012, 59972.700136499036, 10849.837252441062, 11053.668389948314, 11186.105111591216, 11241.213115081866, 11392.0, 12168.87831121713, 12492.812607810709, 12632.873671263169, 12984.220946742847, 13108.016898732443, 10325.793484130425, 10481.842772358268, 11508.88491115078, 11944.820827687765, 11948.641540753792, 11091.889081109408, 11671.343083455282, 11880.881191187977, 12323.568675096329, 12822.358882056047, 11497.252678575866, 12127.696807579881, 12137.757244855231, 12258.632241032783, 12283.324417157142, 9558.23534117255, 10162.898371016196, 10392.22058345612, 10706.785864282827, 10821.0, 9104.180623743894, 9371.906280937375, 10163.186945044527, 10170.796584068425, 10207.733525272139], "value": 6332.391111516903, "unit": "score"}], "name": "dromaeo_css", "value": 6206.380388576819, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 120.0, 114.0, 117.0, 113.0, 114.0, 113.0, 113.0, 130.0], "value": 116.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 124.0, 149.0, 177.0, 124.0, 148.0, 144.0, 130.0, 187.0, 123.0], "value": 146.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 160.0, 163.0, 160.0, 162.0, 162.0, 162.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 165.0, 76.0, 76.0, 76.0, 74.0, 157.0, 77.0], "value": 93.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 160.0, 84.0, 84.0, 85.0, 153.0, 84.0, 83.0, 142.0], "value": 104.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 119.0, 117.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 150.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 147.0], "value": 146.3, "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, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 66.0, 65.0, 69.0, 66.0, 66.0, 67.0, 65.0], "value": 65.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 67.0, 67.0, 66.0, 66.0, 66.0, 66.0, 66.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 83.0, 82.0, 91.0, 89.0, 85.0, 88.0, 81.0, 85.0, 82.0], "value": 85.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 131.0, 131.0, 135.0, 135.0, 134.0, 135.0, 133.0, 180.0, 143.0], "value": 139.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 176.0, 174.0, 181.0, 174.0, 174.0, 173.0, 179.0, 172.0, 172.0], "value": 174.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 69.0, 69.0, 71.0, 70.0, 70.0, 74.0, 72.0, 69.0, 69.0], "value": 70.6, "unit": "score"}], "name": "kraken", "value": 1581.8, "alertThreshold": 2.0}]} 19:19:33 INFO - Return code: 0 19:19:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:19:33 INFO - # TBPL SUCCESS # 19:19:33 INFO - Running post-action listener: _resource_record_post_action 19:19:33 INFO - [mozharness: 2016-09-02 02:19:33.300913Z] Finished run-tests step (success) 19:19:33 INFO - Running post-run listener: _resource_record_post_run 19:19:33 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 0; Write bytes: 424439808; Read time: 0; Write time: 377968 19:19:33 INFO - TinderboxPrint: CPU usage
13.1% 19:19:33 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 19:19:33 INFO - TinderboxPrint: I/O write bytes / time
424,439,808 / 377,968 19:19:33 INFO - TinderboxPrint: CPU idle
8,343.8 (86.9%) 19:19:33 INFO - TinderboxPrint: CPU user
1,206.1 (12.6%) 19:19:33 INFO - TinderboxPrint: Swap in / out
0 / 0 19:19:33 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 130400256; Read time: 0; Write time: 128920 19:19:33 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 293744640; Read time: 0; Write time: 249024 19:19:33 INFO - Running post-run listener: _upload_blobber_files 19:19:33 INFO - Blob upload gear active. 19:19:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:19:33 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 19:19:33 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:19:33 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:19:34 INFO - (blobuploader) - INFO - Open directory for files ... 19:19:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:19:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:19:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:19:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:19:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:19:37 INFO - (blobuploader) - INFO - Done attempting. 19:19:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:19:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:19:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:19:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:19:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:19:41 INFO - (blobuploader) - INFO - Done attempting. 19:19:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:19:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:19:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:19:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:19:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:19:42 INFO - (blobuploader) - INFO - Done attempting. 19:19:42 INFO - (blobuploader) - INFO - Iteration through files over. 19:19:42 INFO - Return code: 0 19:19:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:19:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:19:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/145c7f8de879459404088ce77f1dcbd91b84c3204f3c7d50f63552a81e21c95249d815e940a942aaed8c0aff817589a14986316fdd667b3968ced3ad0e45ae13", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fcc74653c0dc4d19eeb2006d952edbbdca41da3b453c136f3b6f1acb3dd702d795263d7713e5959e4f15395fa11d435d0331e1137aedff68da2fc171ffcc6e5d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/62b12cced882515979ecfc1ca5188dfcbacec9ce8e106a02f88289de9e8883938651dda0de547cd1900203d2051d690258ca84b71317f43358c79a1c969d0093"} 19:19:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:19:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:19:42 INFO - Contents: 19:19:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/145c7f8de879459404088ce77f1dcbd91b84c3204f3c7d50f63552a81e21c95249d815e940a942aaed8c0aff817589a14986316fdd667b3968ced3ad0e45ae13", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fcc74653c0dc4d19eeb2006d952edbbdca41da3b453c136f3b6f1acb3dd702d795263d7713e5959e4f15395fa11d435d0331e1137aedff68da2fc171ffcc6e5d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/62b12cced882515979ecfc1ca5188dfcbacec9ce8e106a02f88289de9e8883938651dda0de547cd1900203d2051d690258ca84b71317f43358c79a1c969d0093"} 19:19:42 INFO - Running post-run listener: copy_logs_to_upload_dir 19:19:42 INFO - Copying logs to upload dir... 19:19:42 INFO - mkdir: /builds/slave/test/build/upload/logs 19:19:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.971328 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-09-01 19:19:41.733017) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 19:19:41.736461) ========= 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=826874ccc97bd7bf541b4875000001d5-1472781137.244611-209123321 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-Non-PGO/sha512/145c7f8de879459404088ce77f1dcbd91b84c3204f3c7d50f63552a81e21c95249d815e940a942aaed8c0aff817589a14986316fdd667b3968ced3ad0e45ae13", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fcc74653c0dc4d19eeb2006d952edbbdca41da3b453c136f3b6f1acb3dd702d795263d7713e5959e4f15395fa11d435d0331e1137aedff68da2fc171ffcc6e5d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/62b12cced882515979ecfc1ca5188dfcbacec9ce8e106a02f88289de9e8883938651dda0de547cd1900203d2051d690258ca84b71317f43358c79a1c969d0093"} build_url:https://queue.taskcluster.net/v1/task/cGGtJNvVTsqvQiT7W1Ebeg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011370 build_url: 'https://queue.taskcluster.net/v1/task/cGGtJNvVTsqvQiT7W1Ebeg/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-Non-PGO/sha512/145c7f8de879459404088ce77f1dcbd91b84c3204f3c7d50f63552a81e21c95249d815e940a942aaed8c0aff817589a14986316fdd667b3968ced3ad0e45ae13", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fcc74653c0dc4d19eeb2006d952edbbdca41da3b453c136f3b6f1acb3dd702d795263d7713e5959e4f15395fa11d435d0331e1137aedff68da2fc171ffcc6e5d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/62b12cced882515979ecfc1ca5188dfcbacec9ce8e106a02f88289de9e8883938651dda0de547cd1900203d2051d690258ca84b71317f43358c79a1c969d0093"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 19:19:41.766180) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 19:19:41.766514) ========= 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=826874ccc97bd7bf541b4875000001d5-1472781137.244611-209123321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004518 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 19:19:41.850657) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 19:19:41.851578) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 19:19:41.852306) ========= ========= Total master_lag: 0.17 =========