builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-060 starttime: 1472797431.32 results: success (0) buildid: 20160901203019 builduid: 96f48c5383af4306a6fa611722512dd4 revision: 4f8bafdd88dc6cfdb5b5fe074dfb5d1abdb2f20c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 23:23:51.325085) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 23:23:51.325443) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 23:23:51.325707) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 23:23:51.341677) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 23:23:51.342040) ========= 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=337fe3f4b1febe37b85fccc40000019e-1472797235.716848-624849905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-01 23:23: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-09-01 23:23:51 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.090518 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 23:23:51.453131) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 23:23:51.453647) ========= 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=337fe3f4b1febe37b85fccc40000019e-1472797235.716848-624849905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020377 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 23:23:51.510019) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-01 23:23:51.510317) ========= 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=337fe3f4b1febe37b85fccc40000019e-1472797235.716848-624849905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-01 23:23:51,931 truncating revision to first 12 chars 2016-09-01 23:23:51,931 Setting DEBUG logging. 2016-09-01 23:23:51,931 attempt 1/10 2016-09-01 23:23:51,931 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4f8bafdd88dc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-01 23:23:52,935 unpacking tar archive at: fx-team-4f8bafdd88dc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.352283 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-01 23:23:52.886427) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 23:23:52.886694) ========= script_repo_revision: 4f8bafdd88dc6cfdb5b5fe074dfb5d1abdb2f20c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 23:23:52.887059) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 23:23:52.887327) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 23:23:52.907412) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-09-01 23:23:52.907669) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1472797235.716848-624849905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:23:53 INFO - MultiFileLogger online at 20160901 23:23:53 in /builds/slave/test 23:23:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:23:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:23:53 INFO - {'append_to_log': False, 23:23:53 INFO - 'base_work_dir': '/builds/slave/test', 23:23:53 INFO - 'blob_upload_branch': 'Fx-Team', 23:23:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:23:53 INFO - 'branch': 'Fx-Team', 23:23:53 INFO - 'buildbot_json_path': 'buildprops.json', 23:23:53 INFO - 'config_files': ('talos/linux_config.py',), 23:23:53 INFO - 'default_actions': ('clobber', 23:23:53 INFO - 'read-buildbot-config', 23:23:53 INFO - 'download-and-extract', 23:23:53 INFO - 'populate-webroot', 23:23:53 INFO - 'create-virtualenv', 23:23:53 INFO - 'install', 23:23:53 INFO - 'run-tests'), 23:23:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:23:53 INFO - 'download_minidump_stackwalk': True, 23:23:53 INFO - 'download_symbols': 'ondemand', 23:23:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:23:53 INFO - 'tooltool.py': '/tools/tooltool.py', 23:23:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:23:53 INFO - '/tools/misc-python/virtualenv.py')}, 23:23:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:23:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:23:53 INFO - 'installer_path': 'installer.exe', 23:23:53 INFO - 'log_level': 'info', 23:23:53 INFO - 'log_name': 'talos', 23:23:53 INFO - 'log_to_console': True, 23:23:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:23:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:23:53 INFO - 'opt_config_files': (), 23:23:53 INFO - 'pip_index': False, 23:23:53 INFO - 'sps_profile': False, 23:23:53 INFO - 'sps_profile_interval': 0, 23:23:53 INFO - 'suite': 'dromaeojs', 23:23:53 INFO - 'system_bits': '32', 23:23:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:23:53 INFO - 'title': 'talos-linux64-ix-060', 23:23:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:23:53 INFO - 'use_talos_json': True, 23:23:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:23:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:23:53 INFO - 'work_dir': 'build'} 23:23:53 INFO - [mozharness: 2016-09-02 06:23:53.422228Z] Running clobber step. 23:23:53 INFO - Running pre-action listener: _resource_record_pre_action 23:23:53 INFO - Running main action method: clobber 23:23:53 INFO - rmtree: /builds/slave/test/build 23:23:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:23:54 INFO - Running post-action listener: _resource_record_post_action 23:23:54 INFO - [mozharness: 2016-09-02 06:23:54.400862Z] Finished clobber step (success) 23:23:54 INFO - [mozharness: 2016-09-02 06:23:54.400964Z] Running read-buildbot-config step. 23:23:54 INFO - Running pre-action listener: _resource_record_pre_action 23:23:54 INFO - Running main action method: read_buildbot_config 23:23:54 INFO - Using buildbot properties: 23:23:54 INFO - { 23:23:54 INFO - "project": "", 23:23:54 INFO - "product": "firefox", 23:23:54 INFO - "script_repo_revision": "production", 23:23:54 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 23:23:54 INFO - "repository": "", 23:23:54 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 23:23:54 INFO - "buildid": "20160901203019", 23:23:54 INFO - "pgo_build": "True", 23:23:54 INFO - "basedir": "/builds/slave/test", 23:23:54 INFO - "buildnumber": 1025, 23:23:54 INFO - "slavename": "talos-linux64-ix-060", 23:23:54 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:23:54 INFO - "platform": "ubuntu64_hw", 23:23:54 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:23:54 INFO - "branch": "fx-team", 23:23:54 INFO - "repo_path": "integration/fx-team", 23:23:54 INFO - "revision": "4f8bafdd88dc6cfdb5b5fe074dfb5d1abdb2f20c", 23:23:54 INFO - "stage_platform": "linux64-pgo", 23:23:54 INFO - "builduid": "96f48c5383af4306a6fa611722512dd4", 23:23:54 INFO - "slavebuilddir": "test" 23:23:54 INFO - } 23:23:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/W10e_HY_Qua1LTWSUl876A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 23:23:54 INFO - Running post-action listener: _resource_record_post_action 23:23:54 INFO - [mozharness: 2016-09-02 06:23:54.403385Z] Finished read-buildbot-config step (success) 23:23:54 INFO - [mozharness: 2016-09-02 06:23:54.403475Z] Running download-and-extract step. 23:23:54 INFO - Running pre-action listener: _resource_record_pre_action 23:23:54 INFO - Running main action method: download_and_extract 23:23:54 INFO - mkdir: /builds/slave/test/build/tests 23:23: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')]} 23:23:54 INFO - trying https://queue.taskcluster.net/v1/task/W10e_HY_Qua1LTWSUl876A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 23:23:54 INFO - Downloading https://queue.taskcluster.net/v1/task/W10e_HY_Qua1LTWSUl876A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 23:23:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W10e_HY_Qua1LTWSUl876A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 23:23:54 INFO - Downloaded 1361 bytes. 23:23:54 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 23:23:54 INFO - Using the following test package requirements: 23:23:54 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 23:23:54 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:23:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:23:54 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:23:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:23:54 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:23:54 INFO - u'jsshell-linux-x86_64.zip'], 23:23:54 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:23:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:23:54 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 23:23:54 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:23:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:23:54 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:23:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:23:54 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:23:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:23:54 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:23:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:23:54 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:23: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')]} 23:23:54 INFO - trying https://queue.taskcluster.net/v1/task/W10e_HY_Qua1LTWSUl876A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 23:23:54 INFO - Downloading https://queue.taskcluster.net/v1/task/W10e_HY_Qua1LTWSUl876A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 23:23:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W10e_HY_Qua1LTWSUl876A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:23:55 INFO - Downloaded 21906606 bytes. 23:23: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 23:24:00 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:24:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:00 INFO - trying https://queue.taskcluster.net/v1/task/W10e_HY_Qua1LTWSUl876A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 23:24:00 INFO - Downloading https://queue.taskcluster.net/v1/task/W10e_HY_Qua1LTWSUl876A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 23:24:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W10e_HY_Qua1LTWSUl876A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:24:00 INFO - Downloaded 21906606 bytes. 23:24: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 23:24: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')]} 23:24:05 INFO - trying https://queue.taskcluster.net/v1/task/W10e_HY_Qua1LTWSUl876A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 23:24:05 INFO - Downloading https://queue.taskcluster.net/v1/task/W10e_HY_Qua1LTWSUl876A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 23:24:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W10e_HY_Qua1LTWSUl876A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:24:06 INFO - Downloaded 14413998 bytes. 23:24: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 23:24:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:07 INFO - trying https://queue.taskcluster.net/v1/task/W10e_HY_Qua1LTWSUl876A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:24:07 INFO - Downloading https://queue.taskcluster.net/v1/task/W10e_HY_Qua1LTWSUl876A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:24:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W10e_HY_Qua1LTWSUl876A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:24:08 INFO - Downloaded 59740906 bytes. 23:24:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/W10e_HY_Qua1LTWSUl876A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:24:08 INFO - mkdir: /builds/slave/test/properties 23:24:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:24:08 INFO - Writing to file /builds/slave/test/properties/build_url 23:24:08 INFO - Contents: 23:24:08 INFO - build_url:https://queue.taskcluster.net/v1/task/W10e_HY_Qua1LTWSUl876A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:24:09 INFO - Running post-action listener: _resource_record_post_action 23:24:09 INFO - Running post-action listener: set_extra_try_arguments 23:24:09 INFO - [mozharness: 2016-09-02 06:24:09.489635Z] Finished download-and-extract step (success) 23:24:09 INFO - [mozharness: 2016-09-02 06:24:09.489861Z] Running populate-webroot step. 23:24:09 INFO - Running pre-action listener: _resource_record_pre_action 23:24:09 INFO - Running main action method: populate_webroot 23:24:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:24:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:24:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:24:09 INFO - '--tppagecycles', 23:24:09 INFO - '7'], 23:24:09 INFO - 'tests': ['tsvgm']}}, 23:24:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:24:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:24:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:24:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:24:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:24:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:24:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:09 INFO - 'talos_options': ['--disable-e10s'], 23:24:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:24:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:24:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:09 INFO - 'talos_options': ['--disable-e10s'], 23:24:09 INFO - 'tests': ['damp', 'tps']}, 23:24:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:09 INFO - 'tests': ['damp', 'tps']}, 23:24:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:24:09 INFO - 'tests': ['dromaeo_dom']}, 23:24:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:24:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:24:09 INFO - 'tests': ['basic_compositor_video']}, 23:24:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:24:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:24:09 INFO - 'tests': ['a11yr', 23:24:09 INFO - 'ts_paint', 23:24:09 INFO - 'tpaint', 23:24:09 INFO - 'sessionrestore', 23:24:09 INFO - 'sessionrestore_no_auto_restore', 23:24:09 INFO - 'tabpaint']}, 23:24:09 INFO - 'other-e10s': {'tests': ['a11yr', 23:24:09 INFO - 'ts_paint', 23:24:09 INFO - 'tpaint', 23:24:09 INFO - 'sessionrestore', 23:24:09 INFO - 'sessionrestore_no_auto_restore', 23:24:09 INFO - 'tabpaint']}, 23:24:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:24:09 INFO - 'ts_paint', 23:24:09 INFO - 'tpaint', 23:24:09 INFO - 'sessionrestore', 23:24:09 INFO - 'sessionrestore_no_auto_restore', 23:24:09 INFO - 'tabpaint']}, 23:24:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:24:09 INFO - 'ts_paint', 23:24:09 INFO - 'tpaint', 23:24:09 INFO - 'sessionrestore', 23:24:09 INFO - 'sessionrestore_no_auto_restore', 23:24:09 INFO - 'tabpaint']}, 23:24:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:24:09 INFO - 'tests': ['a11yr', 23:24:09 INFO - 'ts_paint', 23:24:09 INFO - 'tpaint', 23:24:09 INFO - 'sessionrestore', 23:24:09 INFO - 'sessionrestore_no_auto_restore', 23:24:09 INFO - 'tabpaint']}, 23:24:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:24:09 INFO - 'tests': ['a11yr', 23:24:09 INFO - 'ts_paint', 23:24:09 INFO - 'tpaint', 23:24:09 INFO - 'sessionrestore', 23:24:09 INFO - 'sessionrestore_no_auto_restore', 23:24:09 INFO - 'tabpaint']}, 23:24:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:24:09 INFO - 'tests': ['tsvgx', 23:24:09 INFO - 'tsvgr_opacity', 23:24:09 INFO - 'tart', 23:24:09 INFO - 'tscrollx', 23:24:09 INFO - 'cart']}, 23:24:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:24:09 INFO - 'tsvgr_opacity', 23:24:09 INFO - 'tart', 23:24:09 INFO - 'tscrollx', 23:24:09 INFO - 'cart']}, 23:24:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:09 INFO - 'talos_options': ['--disable-e10s'], 23:24:09 INFO - 'tests': ['tp5o']}, 23:24:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:09 INFO - 'tests': ['tp5o']}, 23:24:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:09 INFO - 'talos_options': ['--disable-e10s', 23:24:09 INFO - '--xperf_path', 23:24:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:24:09 INFO - 'tests': ['tp5n']}, 23:24:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:09 INFO - 'talos_options': ['--xperf_path', 23:24:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:24:09 INFO - 'tests': ['tp5n']}}, 23:24:09 INFO - 'talos.zip': {'path': '', 23:24:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:24:09 INFO - Running post-action listener: _resource_record_post_action 23:24:09 INFO - [mozharness: 2016-09-02 06:24:09.510185Z] Finished populate-webroot step (success) 23:24:09 INFO - [mozharness: 2016-09-02 06:24:09.510274Z] Running create-virtualenv step. 23:24:09 INFO - Running pre-action listener: _resource_record_pre_action 23:24:09 INFO - Running main action method: create_virtualenv 23:24:09 INFO - Creating virtualenv /builds/slave/test/build/venv 23:24:09 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 23:24:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:24:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:24:09 INFO - Using real prefix '/usr' 23:24:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:24:10 INFO - Installing distribute.............................................................................................................................................................................................done. 23:24:12 INFO - Installing pip.................done. 23:24:12 INFO - Return code: 0 23:24:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:24:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a320a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23d68d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2465760>, '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 0x2466660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2466af0>, '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': '337fe3f4b1febe37b85fccc40000019e-1472797235.716848-624849905', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:24:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:24:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:24:12 INFO - Using env: {'DISPLAY': ':0', 23:24:12 INFO - 'HOME': '/home/cltbld', 23:24:12 INFO - 'LANG': 'en_US.UTF-8', 23:24:12 INFO - 'LANGUAGE': 'en_US:en', 23:24:12 INFO - 'LOGNAME': 'cltbld', 23:24:12 INFO - 'MAIL': '/var/mail/cltbld', 23:24:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:12 INFO - 'MOZ_NO_REMOTE': '1', 23:24:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:12 INFO - 'NO_EM_RESTART': '1', 23:24:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:12 INFO - 'PWD': '/builds/slave/test', 23:24:12 INFO - 'SHELL': '/bin/bash', 23:24:12 INFO - 'SHLVL': '1', 23:24:12 INFO - 'TERM': 'linux', 23:24:12 INFO - 'TMOUT': '86400', 23:24:12 INFO - 'USER': 'cltbld', 23:24:12 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1472797235.716848-624849905', 23:24:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:12 INFO - '_': '/tools/buildbot/bin/python'} 23:24:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:12 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 23:24:12 INFO - Cleaning up... 23:24:12 INFO - Return code: 0 23:24:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:24:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a320a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23d68d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2465760>, '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 0x2466660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2466af0>, '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': '337fe3f4b1febe37b85fccc40000019e-1472797235.716848-624849905', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:24:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 23:24:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 23:24:12 INFO - Using env: {'DISPLAY': ':0', 23:24:12 INFO - 'HOME': '/home/cltbld', 23:24:12 INFO - 'LANG': 'en_US.UTF-8', 23:24:12 INFO - 'LANGUAGE': 'en_US:en', 23:24:12 INFO - 'LOGNAME': 'cltbld', 23:24:12 INFO - 'MAIL': '/var/mail/cltbld', 23:24:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:12 INFO - 'MOZ_NO_REMOTE': '1', 23:24:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:12 INFO - 'NO_EM_RESTART': '1', 23:24:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:12 INFO - 'PWD': '/builds/slave/test', 23:24:12 INFO - 'SHELL': '/bin/bash', 23:24:12 INFO - 'SHLVL': '1', 23:24:12 INFO - 'TERM': 'linux', 23:24:12 INFO - 'TMOUT': '86400', 23:24:12 INFO - 'USER': 'cltbld', 23:24:12 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1472797235.716848-624849905', 23:24:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:12 INFO - '_': '/tools/buildbot/bin/python'} 23:24:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:12 INFO - Downloading/unpacking psutil>=3.1.1 23:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:24:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:24:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:24:14 INFO - Installing collected packages: psutil 23:24:14 INFO - Running setup.py install for psutil 23:24:14 INFO - building 'psutil._psutil_linux' extension 23:24:14 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 23:24:14 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 23:24:14 INFO - building 'psutil._psutil_posix' extension 23:24:14 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 23:24:14 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 23:24:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:24:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:24:15 INFO - Successfully installed psutil 23:24:15 INFO - Cleaning up... 23:24:15 INFO - Return code: 0 23:24:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:15 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 0x7f9a320a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23d68d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2465760>, '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 0x2466660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2466af0>, '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': '337fe3f4b1febe37b85fccc40000019e-1472797235.716848-624849905', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:24:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:24:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:24:15 INFO - Using env: {'DISPLAY': ':0', 23:24:15 INFO - 'HOME': '/home/cltbld', 23:24:15 INFO - 'LANG': 'en_US.UTF-8', 23:24:15 INFO - 'LANGUAGE': 'en_US:en', 23:24:15 INFO - 'LOGNAME': 'cltbld', 23:24:15 INFO - 'MAIL': '/var/mail/cltbld', 23:24:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:15 INFO - 'MOZ_NO_REMOTE': '1', 23:24:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:15 INFO - 'NO_EM_RESTART': '1', 23:24:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:15 INFO - 'PWD': '/builds/slave/test', 23:24:15 INFO - 'SHELL': '/bin/bash', 23:24:15 INFO - 'SHLVL': '1', 23:24:15 INFO - 'TERM': 'linux', 23:24:15 INFO - 'TMOUT': '86400', 23:24:15 INFO - 'USER': 'cltbld', 23:24:15 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1472797235.716848-624849905', 23:24:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:15 INFO - '_': '/tools/buildbot/bin/python'} 23:24:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:24:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:24:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:24:17 INFO - Installing collected packages: mozsystemmonitor 23:24:17 INFO - Running setup.py install for mozsystemmonitor 23:24:17 INFO - Successfully installed mozsystemmonitor 23:24:17 INFO - Cleaning up... 23:24:17 INFO - Return code: 0 23:24:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:24:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a320a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23d68d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2465760>, '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 0x2466660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2466af0>, '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': '337fe3f4b1febe37b85fccc40000019e-1472797235.716848-624849905', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:24:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 23:24:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 23:24:17 INFO - Using env: {'DISPLAY': ':0', 23:24:17 INFO - 'HOME': '/home/cltbld', 23:24:17 INFO - 'LANG': 'en_US.UTF-8', 23:24:17 INFO - 'LANGUAGE': 'en_US:en', 23:24:17 INFO - 'LOGNAME': 'cltbld', 23:24:17 INFO - 'MAIL': '/var/mail/cltbld', 23:24:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:17 INFO - 'MOZ_NO_REMOTE': '1', 23:24:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:17 INFO - 'NO_EM_RESTART': '1', 23:24:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:17 INFO - 'PWD': '/builds/slave/test', 23:24:17 INFO - 'SHELL': '/bin/bash', 23:24:17 INFO - 'SHLVL': '1', 23:24:17 INFO - 'TERM': 'linux', 23:24:17 INFO - 'TMOUT': '86400', 23:24:17 INFO - 'USER': 'cltbld', 23:24:17 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1472797235.716848-624849905', 23:24:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:17 INFO - '_': '/tools/buildbot/bin/python'} 23:24:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:17 INFO - Downloading/unpacking jsonschema==2.5.1 23:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:24:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:19 INFO - Downloading functools32-3.2.3-2.tar.gz 23:24:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:24:19 INFO - warning: no files found matching '*.txt' 23:24:19 INFO - no previously-included directories found matching 'build' 23:24:19 INFO - no previously-included directories found matching 'dist' 23:24:19 INFO - no previously-included directories found matching '.git*' 23:24:19 INFO - Installing collected packages: jsonschema, functools32 23:24:19 INFO - Running setup.py install for functools32 23:24:19 INFO - warning: no files found matching '*.txt' 23:24:19 INFO - no previously-included directories found matching 'build' 23:24:19 INFO - no previously-included directories found matching 'dist' 23:24:19 INFO - no previously-included directories found matching '.git*' 23:24:19 INFO - Successfully installed jsonschema functools32 23:24:19 INFO - Cleaning up... 23:24:19 INFO - Return code: 0 23:24:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:24:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a320a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23d68d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2465760>, '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 0x2466660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2466af0>, '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': '337fe3f4b1febe37b85fccc40000019e-1472797235.716848-624849905', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:24:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 23:24:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 23:24:19 INFO - Using env: {'DISPLAY': ':0', 23:24:19 INFO - 'HOME': '/home/cltbld', 23:24:19 INFO - 'LANG': 'en_US.UTF-8', 23:24:19 INFO - 'LANGUAGE': 'en_US:en', 23:24:19 INFO - 'LOGNAME': 'cltbld', 23:24:19 INFO - 'MAIL': '/var/mail/cltbld', 23:24:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:19 INFO - 'MOZ_NO_REMOTE': '1', 23:24:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:19 INFO - 'NO_EM_RESTART': '1', 23:24:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:19 INFO - 'PWD': '/builds/slave/test', 23:24:19 INFO - 'SHELL': '/bin/bash', 23:24:19 INFO - 'SHLVL': '1', 23:24:19 INFO - 'TERM': 'linux', 23:24:19 INFO - 'TMOUT': '86400', 23:24:19 INFO - 'USER': 'cltbld', 23:24:19 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1472797235.716848-624849905', 23:24:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:19 INFO - '_': '/tools/buildbot/bin/python'} 23:24:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:24:20 INFO - Cleaning up... 23:24:20 INFO - Return code: 0 23:24:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:24:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:20 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 0x7f9a320a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23d68d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2465760>, '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 0x2466660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2466af0>, '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': '337fe3f4b1febe37b85fccc40000019e-1472797235.716848-624849905', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:24:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:24:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:24:20 INFO - Using env: {'DISPLAY': ':0', 23:24:20 INFO - 'HOME': '/home/cltbld', 23:24:20 INFO - 'LANG': 'en_US.UTF-8', 23:24:20 INFO - 'LANGUAGE': 'en_US:en', 23:24:20 INFO - 'LOGNAME': 'cltbld', 23:24:20 INFO - 'MAIL': '/var/mail/cltbld', 23:24:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:20 INFO - 'MOZ_NO_REMOTE': '1', 23:24:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:20 INFO - 'NO_EM_RESTART': '1', 23:24:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:20 INFO - 'PWD': '/builds/slave/test', 23:24:20 INFO - 'SHELL': '/bin/bash', 23:24:20 INFO - 'SHLVL': '1', 23:24:20 INFO - 'TERM': 'linux', 23:24:20 INFO - 'TMOUT': '86400', 23:24:20 INFO - 'USER': 'cltbld', 23:24:20 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1472797235.716848-624849905', 23:24:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:20 INFO - '_': '/tools/buildbot/bin/python'} 23:24:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:20 INFO - Downloading/unpacking blobuploader==1.2.4 23:24:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:22 INFO - Downloading blobuploader-1.2.4.tar.gz 23:24:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:24:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:24:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:22 INFO - Downloading docopt-0.6.1.tar.gz 23:24:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:24:23 INFO - Installing collected packages: blobuploader, requests, docopt 23:24:23 INFO - Running setup.py install for blobuploader 23:24:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:24:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:24:23 INFO - Running setup.py install for requests 23:24:23 INFO - Running setup.py install for docopt 23:24:23 INFO - Successfully installed blobuploader requests docopt 23:24:23 INFO - Cleaning up... 23:24:23 INFO - Return code: 0 23:24:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:24:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a320a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23d68d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2465760>, '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 0x2466660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2466af0>, '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': '337fe3f4b1febe37b85fccc40000019e-1472797235.716848-624849905', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:24:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:24:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:24:23 INFO - Using env: {'DISPLAY': ':0', 23:24:23 INFO - 'HOME': '/home/cltbld', 23:24:23 INFO - 'LANG': 'en_US.UTF-8', 23:24:23 INFO - 'LANGUAGE': 'en_US:en', 23:24:23 INFO - 'LOGNAME': 'cltbld', 23:24:23 INFO - 'MAIL': '/var/mail/cltbld', 23:24:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:23 INFO - 'MOZ_NO_REMOTE': '1', 23:24:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:23 INFO - 'NO_EM_RESTART': '1', 23:24:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:23 INFO - 'PWD': '/builds/slave/test', 23:24:23 INFO - 'SHELL': '/bin/bash', 23:24:23 INFO - 'SHLVL': '1', 23:24:23 INFO - 'TERM': 'linux', 23:24:23 INFO - 'TMOUT': '86400', 23:24:23 INFO - 'USER': 'cltbld', 23:24:23 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1472797235.716848-624849905', 23:24:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:23 INFO - '_': '/tools/buildbot/bin/python'} 23:24:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:24:23 INFO - Running setup.py (path:/tmp/pip-A7sX24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:24:23 INFO - Running setup.py (path:/tmp/pip-nybofP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:24:24 INFO - Running setup.py (path:/tmp/pip-y2qu4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:24:24 INFO - Running setup.py (path:/tmp/pip-rY3uyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:24:24 INFO - Running setup.py (path:/tmp/pip-9f9pUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:24:24 INFO - Running setup.py (path:/tmp/pip-e2e0Jf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:24:24 INFO - Running setup.py (path:/tmp/pip-6mQK2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:24:24 INFO - Running setup.py (path:/tmp/pip-no2Gnw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:24:24 INFO - Running setup.py (path:/tmp/pip-DN72aP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:24:24 INFO - Running setup.py (path:/tmp/pip-GNh63j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:24:24 INFO - Running setup.py (path:/tmp/pip-eevNfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:24:24 INFO - Running setup.py (path:/tmp/pip-WyAtfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:24:24 INFO - Running setup.py (path:/tmp/pip-pxc5A5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:24:24 INFO - Running setup.py (path:/tmp/pip-ASpsFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:24:24 INFO - Running setup.py (path:/tmp/pip-3Etx3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:24:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:24:24 INFO - Running setup.py (path:/tmp/pip-O5sXI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:24:25 INFO - Running setup.py (path:/tmp/pip-SvnRw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:24:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:24:25 INFO - Running setup.py install for manifestparser 23:24:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:24:25 INFO - Running setup.py install for mozcrash 23:24:25 INFO - Running setup.py install for mozdebug 23:24:25 INFO - Running setup.py install for mozdevice 23:24:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:24:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:24:25 INFO - Running setup.py install for mozfile 23:24:25 INFO - Running setup.py install for mozhttpd 23:24:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:24:25 INFO - Running setup.py install for mozinfo 23:24:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:24:25 INFO - Running setup.py install for mozInstall 23:24:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:24:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:24:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:24:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:24:25 INFO - Running setup.py install for mozleak 23:24:26 INFO - Running setup.py install for mozlog 23:24:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:24:26 INFO - Running setup.py install for moznetwork 23:24:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:24:26 INFO - Running setup.py install for mozprocess 23:24:26 INFO - Running setup.py install for mozprofile 23:24:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:24:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:24:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:24:26 INFO - Running setup.py install for mozrunner 23:24:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:24:26 INFO - Running setup.py install for mozscreenshot 23:24:26 INFO - Running setup.py install for moztest 23:24:26 INFO - Running setup.py install for mozversion 23:24:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:24:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:24:26 INFO - Cleaning up... 23:24:26 INFO - Return code: 0 23:24:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:24:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a320a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23d68d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2465760>, '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 0x2466660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2466af0>, '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': '337fe3f4b1febe37b85fccc40000019e-1472797235.716848-624849905', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:24:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:24:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:24:26 INFO - Using env: {'DISPLAY': ':0', 23:24:26 INFO - 'HOME': '/home/cltbld', 23:24:26 INFO - 'LANG': 'en_US.UTF-8', 23:24:26 INFO - 'LANGUAGE': 'en_US:en', 23:24:26 INFO - 'LOGNAME': 'cltbld', 23:24:26 INFO - 'MAIL': '/var/mail/cltbld', 23:24:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:26 INFO - 'MOZ_NO_REMOTE': '1', 23:24:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:26 INFO - 'NO_EM_RESTART': '1', 23:24:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:26 INFO - 'PWD': '/builds/slave/test', 23:24:26 INFO - 'SHELL': '/bin/bash', 23:24:26 INFO - 'SHLVL': '1', 23:24:26 INFO - 'TERM': 'linux', 23:24:26 INFO - 'TMOUT': '86400', 23:24:26 INFO - 'USER': 'cltbld', 23:24:26 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1472797235.716848-624849905', 23:24:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:26 INFO - '_': '/tools/buildbot/bin/python'} 23:24:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:24:27 INFO - Running setup.py (path:/tmp/pip-peRszW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:24:27 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 23:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:24:27 INFO - Running setup.py (path:/tmp/pip-7wlhE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:24:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:24:27 INFO - Running setup.py (path:/tmp/pip-HrHU9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:24:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:24:27 INFO - Running setup.py (path:/tmp/pip-GpAkgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:24:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:24:27 INFO - Running setup.py (path:/tmp/pip-xqw9MD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:24:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 23:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:24:27 INFO - Running setup.py (path:/tmp/pip-b5AmhP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:24:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 23:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:24:27 INFO - Running setup.py (path:/tmp/pip-B0T1AX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:24:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 23:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:24:27 INFO - Running setup.py (path:/tmp/pip-JdigC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:24:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 23:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:24:27 INFO - Running setup.py (path:/tmp/pip-3Lvd4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:24:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 23:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:24:27 INFO - Running setup.py (path:/tmp/pip-JZQIZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:24:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:24:27 INFO - Running setup.py (path:/tmp/pip-o2MYpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:24:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 23:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:24:27 INFO - Running setup.py (path:/tmp/pip-XUydDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:24:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:24:28 INFO - Running setup.py (path:/tmp/pip-IN9JVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:24:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 23:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:24:28 INFO - Running setup.py (path:/tmp/pip-vWGRfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:24:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:24:28 INFO - Running setup.py (path:/tmp/pip-2Uqs5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:24:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 23:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:24:28 INFO - Running setup.py (path:/tmp/pip-8btS5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:24:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 23:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:24:28 INFO - Running setup.py (path:/tmp/pip-uH55dn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:24:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 23:24:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:24:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:24:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:24:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:24:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:24:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:30 INFO - Downloading blessings-1.6.tar.gz 23:24:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:24:30 INFO - Installing collected packages: blessings 23:24:30 INFO - Running setup.py install for blessings 23:24:30 INFO - Successfully installed blessings 23:24:30 INFO - Cleaning up... 23:24:30 INFO - Return code: 0 23:24:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:24:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:24:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:24:30 INFO - Reading from file tmpfile_stdout 23:24:30 INFO - Current package versions: 23:24:30 INFO - argparse == 1.2.1 23:24:30 INFO - blessings == 1.6 23:24:30 INFO - blobuploader == 1.2.4 23:24:30 INFO - docopt == 0.6.1 23:24:30 INFO - functools32 == 3.2.3-2 23:24:30 INFO - jsonschema == 2.5.1 23:24:30 INFO - manifestparser == 1.1 23:24:30 INFO - mozInstall == 1.12 23:24:30 INFO - mozcrash == 0.17 23:24:30 INFO - mozdebug == 0.1 23:24:30 INFO - mozdevice == 0.48 23:24:30 INFO - mozfile == 1.2 23:24:30 INFO - mozhttpd == 0.7 23:24:30 INFO - mozinfo == 0.9 23:24:30 INFO - mozleak == 0.1 23:24:30 INFO - mozlog == 3.3 23:24:30 INFO - moznetwork == 0.27 23:24:30 INFO - mozprocess == 0.23 23:24:30 INFO - mozprofile == 0.28 23:24:30 INFO - mozrunner == 6.12 23:24:30 INFO - mozscreenshot == 0.1 23:24:30 INFO - mozsystemmonitor == 0.3 23:24:30 INFO - moztest == 0.7 23:24:30 INFO - mozversion == 1.4 23:24:30 INFO - psutil == 3.1.1 23:24:30 INFO - requests == 1.2.3 23:24:30 INFO - wsgiref == 0.1.2 23:24:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:24:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a320a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23d68d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2465760>, '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 0x2466660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2466af0>, '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': '337fe3f4b1febe37b85fccc40000019e-1472797235.716848-624849905', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:24:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 23:24:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:24:30 INFO - Using env: {'DISPLAY': ':0', 23:24:30 INFO - 'HOME': '/home/cltbld', 23:24:30 INFO - 'LANG': 'en_US.UTF-8', 23:24:30 INFO - 'LANGUAGE': 'en_US:en', 23:24:30 INFO - 'LOGNAME': 'cltbld', 23:24:30 INFO - 'MAIL': '/var/mail/cltbld', 23:24:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:30 INFO - 'MOZ_NO_REMOTE': '1', 23:24:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:30 INFO - 'NO_EM_RESTART': '1', 23:24:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:30 INFO - 'PWD': '/builds/slave/test', 23:24:30 INFO - 'SHELL': '/bin/bash', 23:24:30 INFO - 'SHLVL': '1', 23:24:30 INFO - 'TERM': 'linux', 23:24:30 INFO - 'TMOUT': '86400', 23:24:30 INFO - 'USER': 'cltbld', 23:24:30 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1472797235.716848-624849905', 23:24:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:30 INFO - '_': '/tools/buildbot/bin/python'} 23:24:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:24:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 23:24:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 23:24:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:24:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 23:24:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 23:24:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 23:24:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 23:24:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 23:24:30 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:24:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:24:30 INFO - Cleaning up... 23:24:30 INFO - Return code: 0 23:24:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:24:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a320a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23d68d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2465760>, '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 0x2466660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2466af0>, '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': '337fe3f4b1febe37b85fccc40000019e-1472797235.716848-624849905', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:24:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:24:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:24:30 INFO - Using env: {'DISPLAY': ':0', 23:24:30 INFO - 'HOME': '/home/cltbld', 23:24:30 INFO - 'LANG': 'en_US.UTF-8', 23:24:30 INFO - 'LANGUAGE': 'en_US:en', 23:24:30 INFO - 'LOGNAME': 'cltbld', 23:24:30 INFO - 'MAIL': '/var/mail/cltbld', 23:24:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:30 INFO - 'MOZ_NO_REMOTE': '1', 23:24:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:30 INFO - 'NO_EM_RESTART': '1', 23:24:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:30 INFO - 'PWD': '/builds/slave/test', 23:24:30 INFO - 'SHELL': '/bin/bash', 23:24:30 INFO - 'SHLVL': '1', 23:24:30 INFO - 'TERM': 'linux', 23:24:30 INFO - 'TMOUT': '86400', 23:24:30 INFO - 'USER': 'cltbld', 23:24:30 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1472797235.716848-624849905', 23:24:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:30 INFO - '_': '/tools/buildbot/bin/python'} 23:24:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:24:31 INFO - Cleaning up... 23:24:31 INFO - Return code: 0 23:24:31 INFO - Running post-action listener: _resource_record_post_action 23:24:31 INFO - Running post-action listener: _start_resource_monitoring 23:24:31 INFO - Starting resource monitoring. 23:24:31 INFO - [mozharness: 2016-09-02 06:24:31.189651Z] Finished create-virtualenv step (success) 23:24:31 INFO - [mozharness: 2016-09-02 06:24:31.190162Z] Running install step. 23:24:31 INFO - Running pre-action listener: _resource_record_pre_action 23:24:31 INFO - Running main action method: install 23:24:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:24:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:24:31 INFO - Reading from file tmpfile_stdout 23:24:31 INFO - Detecting whether we're running mozinstall >=1.0... 23:24:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:24:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:24:31 INFO - Reading from file tmpfile_stdout 23:24:31 INFO - Output received: 23:24:31 INFO - Usage: mozinstall [options] installer 23:24:31 INFO - Options: 23:24:31 INFO - -h, --help show this help message and exit 23:24:31 INFO - -d DEST, --destination=DEST 23:24:31 INFO - Directory to install application into. [default: 23:24:31 INFO - "/builds/slave/test"] 23:24:31 INFO - --app=APP Application being installed. [default: firefox] 23:24:31 INFO - mkdir: /builds/slave/test/build/application 23:24:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 23:24:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 23:24:48 INFO - Reading from file tmpfile_stdout 23:24:48 INFO - Output received: 23:24:48 INFO - /builds/slave/test/build/application/firefox/firefox 23:24:48 INFO - Running post-action listener: _resource_record_post_action 23:24:48 INFO - [mozharness: 2016-09-02 06:24:48.502432Z] Finished install step (success) 23:24:48 INFO - [mozharness: 2016-09-02 06:24:48.502710Z] Running run-tests step. 23:24:48 INFO - Running pre-action listener: _resource_record_pre_action 23:24:48 INFO - Running main action method: run_tests 23:24:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:24:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:24:48 INFO - Python 2.7.3 23:24:48 INFO - Return code: 0 23:24:48 INFO - grabbing minidump binary from tooltool 23:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:48 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2465760>, '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 0x2466660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2466af0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:24:48 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 23:24:48 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 23:24:48 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 23:24:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:24:48 INFO - Return code: 0 23:24:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:24:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:24:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:24:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:24:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:24:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W10e_HY_Qua1LTWSUl876A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 23:24:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/W10e_HY_Qua1LTWSUl876A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 23:24:48 INFO - Using env: {'DISPLAY': ':0', 23:24:48 INFO - 'HOME': '/home/cltbld', 23:24:48 INFO - 'LANG': 'en_US.UTF-8', 23:24:48 INFO - 'LANGUAGE': 'en_US:en', 23:24:48 INFO - 'LOGNAME': 'cltbld', 23:24:48 INFO - 'MAIL': '/var/mail/cltbld', 23:24:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:24:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:24:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:48 INFO - 'MOZ_NO_REMOTE': '1', 23:24:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:24:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:48 INFO - 'NO_EM_RESTART': '1', 23:24:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:48 INFO - 'PWD': '/builds/slave/test', 23:24:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:24:48 INFO - 'SHELL': '/bin/bash', 23:24:48 INFO - 'SHLVL': '1', 23:24:48 INFO - 'TERM': 'linux', 23:24:48 INFO - 'TMOUT': '86400', 23:24:48 INFO - 'USER': 'cltbld', 23:24:48 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1472797235.716848-624849905', 23:24:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:48 INFO - '_': '/tools/buildbot/bin/python'} 23:24:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W10e_HY_Qua1LTWSUl876A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 23:24:48 INFO - mozversion application_buildid: 20160901203019 23:24:48 INFO - mozversion application_changeset: 4f8bafdd88dc6cfdb5b5fe074dfb5d1abdb2f20c 23:24:48 INFO - mozversion application_display_name: Nightly 23:24:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:24:48 INFO - mozversion application_name: Firefox 23:24:48 INFO - mozversion application_remotingname: firefox 23:24:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:24:48 INFO - mozversion application_vendor: Mozilla 23:24:48 INFO - mozversion application_version: 51.0a1 23:24:48 INFO - mozversion platform_buildid: 20160901203019 23:24:48 INFO - mozversion platform_changeset: 4f8bafdd88dc6cfdb5b5fe074dfb5d1abdb2f20c 23:24:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:24:48 INFO - mozversion platform_version: 51.0a1 23:24:48 INFO - using testdate: 1472797488 23:24:48 INFO - actual date: 1472797488 23:24:48 INFO - starting webserver on 'localhost:40978' 23:24:48 INFO - SUITE-START | Running 2 tests 23:24:48 INFO - TEST-START | dromaeo_css 23:24:48 INFO - operating with platform_type : linux_ 23:24:48 INFO - Initialising browser for dromaeo_css test... 23:24:48 INFO - TEST-INFO | started process 20009 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp_aVNW/profile http://localhost:40978/getInfo.html) 23:24:53 INFO - PROCESS | 20009 | __metrics Screen width/height:1600/1200 23:24:53 INFO - PROCESS | 20009 | colorDepth:24 23:24:53 INFO - PROCESS | 20009 | Browser inner width/height: 1024/697 23:24:53 INFO - PROCESS | 20009 | __metrics 23:24:53 INFO - PROCESS | 20009 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 23:24:53 INFO - PROCESS | 20009 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:24:54 INFO - PROCESS | 20009 | console.error: PushService: 23:24:54 INFO - PROCESS | 20009 | stateChangeProcessEnqueue: Error transitioning state 23:24:54 INFO - PROCESS | 20009 | UnknownError 23:24:54 INFO - TEST-INFO | 20009: exit 0 23:24:54 INFO - Browser initialized. 23:24:54 INFO - Running cycle 1/1 for dromaeo_css test... 23:24:54 INFO - TEST-INFO | started process 20090 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp_aVNW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:25:06 INFO - PROCESS | 20090 | RSS: Main: 179335168 23:25:06 INFO - PROCESS | 20090 | 23:25:58 INFO - PROCESS | 20090 | 1472797558126 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 23:28:07 INFO - PROCESS | 20090 | Cycle 1(1): loaded http://localhost:40978/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40978/tests/dromaeo/cssquery-ext.html) 23:28:08 INFO - PROCESS | 20090 | RSS: Main: 295718912 23:28:08 INFO - PROCESS | 20090 | 23:31:11 INFO - PROCESS | 20090 | Cycle 1(1): loaded http://localhost:40978/tests/dromaeo/cssquery-ext.html (next: http://localhost:40978/tests/dromaeo/cssquery-jquery.html) 23:31:11 INFO - PROCESS | 20090 | RSS: Main: 273317888 23:31:11 INFO - PROCESS | 20090 | 23:34:14 INFO - PROCESS | 20090 | Cycle 1(1): loaded http://localhost:40978/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40978/tests/dromaeo/cssquery-mootools.html) 23:34:14 INFO - PROCESS | 20090 | RSS: Main: 214163456 23:34:14 INFO - PROCESS | 20090 | 23:37:16 INFO - PROCESS | 20090 | Cycle 1(1): loaded http://localhost:40978/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40978/tests/dromaeo/cssquery-prototype.html) 23:37:17 INFO - PROCESS | 20090 | RSS: Main: 272564224 23:37:17 INFO - PROCESS | 20090 | 23:40:19 INFO - PROCESS | 20090 | Cycle 1(1): loaded http://localhost:40978/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40978/tests/dromaeo/cssquery-yui.html) 23:40:20 INFO - PROCESS | 20090 | RSS: Main: 216977408 23:40:20 INFO - PROCESS | 20090 | 23:43:23 INFO - PROCESS | 20090 | Cycle 1(1): loaded http://localhost:40978/tests/dromaeo/cssquery-yui.html (next: http://localhost:40978/tests/dromaeo/cssquery-dojo.html) 23:43:24 INFO - PROCESS | 20090 | RSS: Main: 305446912 23:43:24 INFO - PROCESS | 20090 | 23:43:24 INFO - PROCESS | 20090 | __start_tp_report 23:43:24 INFO - PROCESS | 20090 | _x_x_mozilla_page_load 23:43:24 INFO - PROCESS | 20090 | _x_x_mozilla_page_load_details 23:43:24 INFO - PROCESS | 20090 | |i|pagename|runs| 23:43:24 INFO - PROCESS | 20090 | |0;dojo.html;3001.6998300169985;3009.98495007525;3034.9999999999986;3048.0551029180942;3086.9536956945635;5153.613478989077;5205.479452054793;5237.3453318335205;5269.367675878895;5277.551408130314;5237.135872581029;5254.343207099113;5311.760970756325;5333.813316533922;5337.626366154371;4718.834840780573;4818.445878723956;4819.951800482003;4823.155947709137;4974.477679843619;4885.5114488551035;4916.287138364935;4947.233178857283;4959.652824302282;4972.279019542164;4669.766511674419;4723.976380118112;4762.595179409755;4790.520947905182;4869.634777391692;4795.424549054101;4800.495947925488;4854.805807767685;4863.732494712789;4875.976045030512;4728.574428301469;4758.072175925696;4767.666263361566;4777.95222047782;4830.758462076882;5193.298904647862;5199;5246.868828279324;5307.177387504943;5312.574994000471;5565.332160140769;5609.803656872031;5616.213730077792;5663.065594176997;5674.9716251418895;5629.915551266734;5648.717564121818;5650.434956504317;5652.34997975234;5655.915161272585;5154.742262886841;5193;5251.396089449724;5253.6322457428;5255.343082114736;5634.098544232903;5678.77284908599;5678.858028549319;5741.712914354265;5749.741261643236;5450.672959622435;5465.726713664301;5502.669839809624;5535.750891209906;5538.9169162462595;5459.181122831607;5477.67133971963;5529.834104976857;5537.556995440355;5547.11246200606;5561.332640083216;5603.215549823028;5612.354579223442;5661.122526008476;5668.376478587352;5575.581831362664;5600.5799565032785;5608.383077861432;5608.663480191201;5614.719264036782;4307.870763877026;4378.562143785596;4383.3863259143745;4391.407160033418;4443.289073748185;3942.704297177723;3947.151362457028;3985.442038114666;4015.6586690131667;4025.879223623296;5379.892402151935;5381.354237491526;5381.811636592701;5382.327209098863;5387;5528.391876893619;5532.3914369419335;5736.282964629421;5753;5760.971195144081;5041.143005689041;5303.257543943851;5305;5345.518903298722;5356.357237131491;4804.879878003008;4805.783739731721;4811.109944660249;4817.927731083966;4865.318855360252;5700.3444603871085;5773.220615216976;5783.913241301468;5791.131330300489;5802.448767367094;5654.943450565442;5683.516901063456;5706.686132262599;5766.452187042224;5768.134779783066;5818.44724751148;5827.737751801264;5838.474537291494;5840.766369345349;5841.50347220474;5429.049916264717;5565.081761509306;5611.130274807411;5611.971940140274;5618.044932361427;5654.15187721845;5727.770889164387;5729.828105156852;5788.189653448437;5798.420157984167;5545.195946587803;5565.526930210977;5614.354349249888;5618.157276408571;5618.606697531297;5436.6194366393975;5484.61607687458;5598.384177740364;5609.691466969356;5617.438256174513;5467.808626698046;5512.118061110203;5514.641548299348;5575.637583557056;5575.8884822304135;5593.748281327269;5593.9440605595055;5601.691906945157;5602.047651899105;5603.943960560342;5361.035013697572;5416.7020813855615;5474.288342515448;5487.862803429946;5490.403257559592 23:43:24 INFO - PROCESS | 20090 | |1;ext.html;571.5827445964446;609.0377204017652;616.9814905552829;625.7403177681264;632.2570979099556;42472;44262.77868610656;44303.335449968275;44420.33369499452;47732;45589.54410455895;45611.77194114033;46042.30936535955;46064.76967615157;46185;8021;8987;9133.862992055092;9134.680286189985;10536.315139515946;10383;10790.946045269802;10830.566777328937;10837;10845.945770271137;10825.945870270638;10901.400422976732;10919.672409827677;10921.12630989519;10923.563057477691;10766.24636275461;10768.407737574431;10830.891691083107;10846.023857852831;10851.67444976652;10725.785484290349;10818.72953176169;10822.458877056195;10826.296290741077;10827.945860270727;42844.78577607123;43172.56827431717;43225.56774432247;43271;43309.13381732379;3604.8017359045243;3668.724845636588;3782.7919464429447;4056.391541268804;4139.606737359946;31749.20626984344;31915.202119946956;32104.6789532104;32254.516182257285;33446;4381.715188512769;4468.262736648449;4513.232750432434;4620.445546534404;4655.4878963314;347181;347683;348129;348561;348574;58686.70656646689;59345.70327148423;59535.404645952985;59604.10593841096;59611.70194149001;61197;61412.69293653503;61483;61521.692391537756;61532.69233653803;17149.056801876017;17427.041512716667;17427.912860435616;17437.564060898578;17441;11999.580014699444;13176.209427434385;13406.463741450429;13543.119697219649;13551.932240338736;17684.557886052695;17721;17861.553461163574;17893.10534473271;18099.63800723978;5741.138829175574;5805.66954482672;5859.121131830174;5917.378675239124;5985.25184351956;922.686286662538;971.2036130373026;987.7678745494803;989.4162444157837;1000.8548760429696;31462.685373146433;31979.360412791615;32123;32238.35523289521;32378.190545236088;1074.3285446595878;1114.9832752508719;1121.8092924202906;1128.15388458656;1129.4747942206914;15979.920100399424;16794.832051679572;16956.915215423844;16969.15154242283;17272.827271727372;494207;497052;498027;498577;498630;57866;57880.4211957875;58039.129413058836;58072.4192758067;58262;1207.486818102303;1273.490603758504;1337.612092493166;1338.3977210255423;1353.1069494134022;30671;31509.52735709012;31982.6801731989;32583.29792286388;33312.83343583267;55633.72183139058;56298.155527667936;56346;56358.436415636956;56405.43594564002;440661;440724;441309;441850;443947;27610.861945690143;28695.282617934718;28749.425011500072;29745.553816692332;29816.123903892356;47124;47474.762626186646;47681.523184769096;47880.76059619679;49327;39714.40428393519;40007.1998560033;40374.39438408485;40787.38818917659;42086.57913420827;38599.61400386073;39243.607563925136;39376.40935385914;40924.79537602293;41652.375214371204;37439.6256037447;40736;42109;42138.78930605327;42251.57748422476;32360.83819580887;36664.63335366719;36995;37054.09320213711;37529.43705844469;27575.86212069007;27646.5853012209;27766.44467110687;28178;28269 23:43:24 INFO - PROCESS | 20090 | |2;jquery.html;368.9040849379161;386.4782543566188;397.5051061428522;402.9174019326038;419.38930159755506;16425.42511012115;19192;19464.318748843794;19551.706724399144;20032.198712051537;15447;15765.290561924712;15777.842221577781;17605.471835844914;19375.32186373477;5595.776168953247;5633.887322253552;5818.825435236929;5830.4461076197695;5831.883362332751;5716.428357164292;5762.366139724627;5812.186293918855;5816.33112192097;5824.388439213864;5590.105583106703;5648.15277708345;5800.854978625547;5803.419658034205;5806.809604031185;5701.971490142564;5738.397468265855;5745.511631511326;5746.454086861741;5752.050911599602;4966.106100901836;5123.590112790967;5155.304033955443;5164.948350516484;5167.250748641426;23136.190233341753;23192.072317107464;23261.88369058161;23303.184388546488;23425.180118695935;2173.608750424923;2933.149386677861;3053.206166396753;3065.111117775842;3071.2014876132143;12957;13668.93165534176;14302.070365426214;14360.210188439632;14476.565703028926;1885.4909174522938;1924.6246981838547;1947.191915355126;1979.7822239553639;2018.8687735297158;83480.58259708724;84529.57735211284;87232.56383718167;87411;89089;10925.617603383844;11269.605563805228;11302.208845380908;11303.491342889425;11471.483783229774;15962.441314553935;16028.278727457293;16039.679206415807;16049.759253611206;16064.27710753019;8189.918100819034;8191.221833925768;8489;8501.957490212633;8528.701495447629;7692.269234422721;7709.537427754352;7768.572728499987;7971.40214483916;8008.039035315799;4622.491525932145;4639.280911458729;4731.976340118346;4864.318995340655;5010.073136469765;1935.5451468904796;1991.4722598511405;2025.9594808103755;2036.5926814637132;2048.897555122238;840.6385254340693;941.7363138321281;956.9712908612753;965.7730433348157;1070.7483741320784;19647.607047858965;20139.39581812548;20268.79731202669;20359.592808143756;20396.184152633727;935.8689783430189;948.8244674735196;963.8457846744487;973.7808992976524;1009.3136667066466;10371.222158338154;10764.838527422095;11008.669739907655;11025.393603351893;11056.447177641086;490955;498958;501416;501488;505660;92139.53930230306;92848.53575732213;95691.52154239184;96388.51805740927;97003;968.4431451915177;1019.3527110284874;1023.9436830974219;1077.3535878472853;1078.730317420645;16512.917435413226;17114.315427382764;17725.822741772416;17763.289468421117;17858.46424607264;44034.46983889097;44349.89550731418;44584;44629.33056004097;46549;56153.43846561482;57431.42568574261;59571;59691;60339;8342.749717508485;8535.274501667427;8538.231559159705;8836.248918841713;9090.045545217657;7613.619319033915;8188.672453102047;8603.913960860562;11130.666080017612;13507.411995045524;11729.237599556001;11750.177487575787;11904.226225295328;11913.404329783649;12491.75016499683;11606.419679016184;11812;11955.462004209658;12108.818367724314;12160.817587736014;11305.26515776472;11693.356865372147;11768.058555315383;12370.62888113358;12510.624681259576;7422.257774222535;7587.127480339611;7684.8463030740195;7869.606519674108;7962;10109.64616238428;11763.647090587296;11857.754935731624;11865.881341186478;11991.520339186683 23:43:24 INFO - PROCESS | 20090 | |3;mootools.html;1189.6371606659966;1440.7838824176372;1484.4062375049982;1526.2750193658007;1722.0872937343204;8369.539675317856;8829.072947340534;8878.023417424094;8878.86681699775;8891.33315001376;8642.783930401743;8746.956265218665;8759.781005474866;8766.167214114665;8826.293896488281;2074.8962551872423;2382.6783384243167;2413.191580820423;2457.8156638252112;2462.212092130519;2437.4515733959893;2458.360826185196;2467.370820440794;2472.666190064336;2479.962800557984;2351.329870986769;2370.762923707624;2389.104085967762;2392.461696118377;2429.8542087474807;2286.7141607299086;2355.1521452277166;2391.9162829300976;2397.8681172535503;2400.1479474786547;2374.2639781667567;2386.9045238190624;2394.1381102802975;2394.628832530943;2395.4370722880108;8743.300535957173;8787.692430764957;8787.956060219658;8798.384113112084;8834.514101724402;5181.326427564392;5204.4535323791215;5348.491893270133;5351.036813373591;5359.678419294816;3386.9661303386897;3480.042988178246;3492.4935884296888;3559.270349578356;3560.2167523144867;1183.1599564309352;1250.7985944737236;1251.330538162079;1267.1383459247709;1281.1288323939718;11887.346195959219;11973.221740586834;12054.999999999913;12061.276323420623;12062.095342849234;4269;4461.643068554573;4620.0990806793025;4628.352030715702;4643.883902902455;9604.615815367308;9615.711528654152;9617.51912404377;9629.518524073908;9631.08504692053;5250;5257.185136303879;5257.631965762436;5259.552938000236;5261.237120617489;4268.701190916606;4796.328514008042;4812.759362031885;4919.458859525449;4928.827491037797;3723.3484140275887;3808.428735689669;3828.062124779391;3878.806059697004;3990.541087774885;1152.3028567716578;1162.0471213604762;1166.7899778040035;1173.612707806422;1174.7591743692522;788.645109700637;811.5860910935465;902.6660135749814;943.834828904939;948.1419315519466;5717.485426311652;5718.1136923776885;5728.198052272685;5787.652740835563;6009.429104235091;456.27452350761786;463.6777439679458;466.55444050931277;469.55861490199106;472.47319239048903;3957.742746721454;3984.900377490586;4008.9198216035516;4016.0763024504527;4024.396340548941;10542.736431589272;10895.346279223271;10950.835737463944;10974.506147223394;11003.064739497233;10824.78350432987;10826.729331766612;10875.67372978796;10889.074428673493;10911.181661375429;8106.756797296091;8155.592220389076;8161.020677518736;8172.67309307633;8180.550069746221;5512.972435137799;5560.165975103605;5575.944240557543;5718.428157184248;5759.819237056309;9832;9902.158316543175;9944.403335799876;9965.50172491358;9975.50122493887;9383.108604682544;9619.422834629664;9745.853812192965;9885.456299903575;10086.29395942277;6921.826954326182;7143.499955003308;7149.070620819468;7718.575478348745;7800.570968596781;7777.222277772177;8191.877121843297;8404.36967227448;8467.026291976255;8634.309255259439;7395.408367330709;7414.62926853666;7566.772996810105;7664.233576642514;7699.30706236419;7273.636318184175;7346.926530734624;7495.512791668524;7536.7362142324755;7832.725854595062;6681.098051763144;6836.726530938707;6840.589564626139;6854.897176542256;6856.41720453767;4790.880227994188;4924.778384972613;4951.1088004158155;4966.205407134841;4995.925061124159;4862.7325497098;4887.877803054952;5000.524845170756;5045.84862454127;5068.898622027613 23:43:24 INFO - PROCESS | 20090 | |4;prototype.html;309.9178717639826;333.46978304495855;334.80079352785083;338.46353529655494;338.852599119383;5200.2719619253285;5281.577473802096;5300.496452836984;5310.362756469224;5347.786088556453;5190.506901844328;5239.502247286511;5242.239875218091;5246.396664383587;5254.81608143715;4125.443065186207;4159.542450330461;4159.92003998001;4173.520045194811;4182.707210495267;4027.5166979962446;4123.917521649565;4127.855525056623;4136.655586934244;4138.875833724993;4111.835526578933;4131.9876630225635;4138.255114079465;4143.482064741907;4148.170365926811;4123.958760412403;4133.91732165358;4134.73124246923;4152.314868046784;4168.145530166309;3703.7222208334215;3720.144366795625;3720.2001569662652;3723.1250656095795;3752.892896595511;5031.345925029759;5152.690838549662;5160.92258616121;5161.7161056141895;5179.8446046618665;4733.668643194977;4750.976245118753;4778.402699662543;4784.138855006097;4785.736784476852;5353.732313384316;5470.64440811346;5486.945130548684;5497.202905578709;5500.834974950758;4005.959940400588;4011.3782363733667;4024.1750441159493;4029.738067025634;4036.112055347848;5433.782648694048;5500.092484740053;5704.80033198836;5714.7428365723645;5718.170865224519;4118.279301122292;4118.341065429577;4158.272302347077;4159.604837540429;4169.874903752831;4168.7707176105605;4172.123853990635;4193.622573968358;4205.36919462077;4219.38818871262;4532.637389008872;4772.832950846704;4777.116233496814;4780.665353425296;4794.544518270759;5494.697791621499;5522.779088836402;5535.5848311376;5546.91679624806;5590.888182236333;1445.5302026841318;1457.9052361596462;1458.2927280269062;1459.5548357750988;1461.4592600737794;919.0296389526471;949.3639261694543;954.0507195340681;965.5365424596092;967.9322447428754;4720.622350211975;4746.28805679144;4748.691335063209;4784.593309568726;4793.544613261734;4955.801767929314;4979.90040199194;5012.774425150877;5021.648484606116;5037.143685573461;4554.453465584151;4602.608778253886;4766.95233047672;4787.257975013878;4806.615470762331;2650.814442989011;2656.6015097735494;2657.6677915260593;2660.2950218192195;2661.0973154194844;5086.745662716849;5111.667741596784;5122.026814905156;5131.820386286462;5139.45816255122;5056.6713163644245;5086.872828179251;5086.974565127225;5369.597280203922;5827.970860145672;5829.417058294137;5865.709543900421;5869.266341707286;5883.529317654577;5892.94107058924;5660.122680984454;5670.546356291405;5675.148727690879;5694.829155125353;5696.458836410535;5496.835094947158;5663.518600918968;5684.886302274014;5704.828855134353;5724.227229323988;5609.411011843861;5723.513501352431;5783.7397317119985;5819.76720931158;5869.266341707286;4011.2378648056774;4046.9797651012736;4056.797160141922;4099.713020088565;4108.938365924573;5634.605577609528;5751.223584815996;5771.076627739541;5774.220480235114;5774.82675519735;5497.8075767347955;5505.229267902417;5511.917321240265;5559.27729395176;5584.944150558605;5508.283923089973;5541.833744987657;5545.833624991256;5584.972075139598;5591;5378.650387724785;5502.8349149525575;5524.91712624319;5529.4470552944385;5553.834004738236;5468.835934921959;5533.059379905345;5542.418046105101;5557.916631250454;5596.188552659923;5435.429279925709;5438.401775804738;5495.53287970527;5497.285352904097;5497.752601132878 23:43:24 INFO - PROCESS | 20090 | |5;yui.html;768.9769306920791;784.9293563579278;831.1646794971053;842.528184216839;844.6030365728105;15414.15222162782;16869.15654217289;16869.57826054346;16902.239399227034;16933.391327823836;14654.560363189095;14700.117992920432;14731.558053258392;14737.778933315982;14756.926215368909;634.6160572853427;746.9850602987937;751.1887161865186;759.9316061554459;770.6994272233806;770.3836930455641;771.0631582627107;771.4252881603186;777.4324742937658;777.9766607001799;826.0747962282252;829.1335554345693;829.8921140251789;830.1117803949776;830.1325115254543;666.4401902401958;815.3803109636659;815.9184081591852;816.7590560784582;817.0930267403178;587.2805812879232;602.0277252237648;602.6474512410246;602.9457348838582;604.9576529642927;14693.853061469463;14755.409783608642;14777.556673299818;14783.852161478355;14784.039037462639;13096.86903130966;13412.798808017887;13913.095648782797;13989.720205595933;14123.505677301246;13153.736925261537;13399.06961949822;13463.326833658279;13472;13677.726445471035;4491.708038977456;4546.772661366918;4552.726836389827;4562;4571.1771881061395;79014;79301;79391.60304198442;80820;85638.57180714118;11417.771644567229;11566.55418072741;11953.701157471132;12078;12115.939420303019;21189.470263243544;21546.353609391743;21605.567888642454;21621.67567486489;21692.674609880865;8653.134686531297;8740.825183496421;8826.602802873886;9059.501727405055;9071.954640226757;4765.833195838129;4806.351142595705;4815.903681926412;4950.331705219821;4958.752062396866;3225.6774322567558;3427.4516077427493;3427.7600567960503;3447.1899103710607;3458.688718015391;561.5844275236295;564.1932037186862;575.5609490316525;587.0958723565747;587.8647910980499;651.3323843060806;659.4954859532462;668.3483603486659;693.2616763147232;704.4857254204358;9057.320700947455;9665.6380901272;9807.166390856715;9833.45915974614;9837;616.1558664629487;667.5393978155057;668.7091115364832;688.4251649872413;717.7846646006177;4323.437953066082;4632.3977882875015;4652.744099074584;4705.294205869079;4814.085323788469;70508;78378.6081069591;88381.55809221041;125864.37067814785;126456;85941.5702921494;86850.56574717212;87625.56187219023;108065;108784;55962.72018639881;70466.64766676133;84599;86258.137418625;87473;9637.614495420105;10124.13944814699;10446.164306855586;10497.317674351143;10519.842202367123;38643.80678096704;49495.25757113718;49522.50477495179;49698;50545;66307.66846165931;74771.62614186894;76386;76744;80902;12530.248185108923;12696.936515317364;12927.806082908575;13134.737305254033;13201.20792752438;15123.319450624529;15296.464623738117;15442.30509627047;15681.45114921018;15719.371225150866;12098;12530.874691252971;14457.566273011826;14697.191654459108;14878.479253226085;13008.154469959421;13025.413856376676;13357.599272021855;13412.597622071353;13867.167969921837;12504;12834.16577922432;13151.868481315447;13476.258805765385;13581.32093395346;9897.55461004271;9927.553260103168;9962.452065136487;10073.597056117673;10266.691999240034;9644.75888102803;10450.454022760521;10490.370577765358;10765.784684306427;11823.408829558659 23:43:24 INFO - PROCESS | 20090 | __end_tp_report 23:43:24 INFO - PROCESS | 20090 | __start_cc_report 23:43:24 INFO - PROCESS | 20090 | _x_x_mozilla_cycle_collect,1051 23:43:24 INFO - PROCESS | 20090 | __end_cc_report 23:43:24 INFO - PROCESS | 20090 | __startTimestamp1472798604091__endTimestamp 23:43:24 INFO - PROCESS | 20090 | 23:43:24 INFO - PROCESS | 20090 | ------- Summary: start ------- 23:43:24 INFO - PROCESS | 20090 | Number of tests: 6 23:43:24 INFO - PROCESS | 20090 | 23:43:24 INFO - PROCESS | 20090 | [#0] dojo.html Cycles:165 Average:5249.06 Median:5467.81 stddev:582.49 (10.7%) stddev-sans-first:556.96 23:43:24 INFO - PROCESS | 20090 | Values: 3001.7 3010.0 3035.0 3048.1 3087.0 5153.6 5205.5 5237.3 5269.4 5277.6 5237.1 5254.3 5311.8 5333.8 5337.6 4718.8 4818.4 4820.0 4823.2 4974.5 4885.5 4916.3 4947.2 4959.7 4972.3 4669.8 4724.0 4762.6 4790.5 4869.6 4795.4 4800.5 4854.8 4863.7 4876.0 4728.6 4758.1 4767.7 4778.0 4830.8 5193.3 5199.0 5246.9 5307.2 5312.6 5565.3 5609.8 5616.2 5663.1 5675.0 5629.9 5648.7 5650.4 5652.3 5655.9 5154.7 5193.0 5251.4 5253.6 5255.3 5634.1 5678.8 5678.9 5741.7 5749.7 5450.7 5465.7 5502.7 5535.8 5538.9 5459.2 5477.7 5529.8 5537.6 5547.1 5561.3 5603.2 5612.4 5661.1 5668.4 5575.6 5600.6 5608.4 5608.7 5614.7 4307.9 4378.6 4383.4 4391.4 4443.3 3942.7 3947.2 3985.4 4015.7 4025.9 5379.9 5381.4 5381.8 5382.3 5387.0 5528.4 5532.4 5736.3 5753.0 5761.0 5041.1 5303.3 5305.0 5345.5 5356.4 4804.9 4805.8 4811.1 4817.9 4865.3 5700.3 5773.2 5783.9 5791.1 5802.4 5654.9 5683.5 5706.7 5766.5 5768.1 5818.4 5827.7 5838.5 5840.8 5841.5 5429.0 5565.1 5611.1 5612.0 5618.0 5654.2 5727.8 5729.8 5788.2 5798.4 5545.2 5565.5 5614.4 5618.2 5618.6 5436.6 5484.6 5598.4 5609.7 5617.4 5467.8 5512.1 5514.6 5575.6 5575.9 5593.7 5593.9 5601.7 5602.0 5603.9 5361.0 5416.7 5474.3 5487.9 5490.4 23:43:24 INFO - PROCESS | 20090 | 23:43:24 INFO - PROCESS | 20090 | [#1] ext.html Cycles:180 Average:59728.25 Median:21191.20 stddev:114558.97 (540.6%) stddev-sans-first:114794.24 23:43:24 INFO - PROCESS | 20090 | Values: 571.6 609.0 617.0 625.7 632.3 42472.0 44262.8 44303.3 44420.3 47732.0 45589.5 45611.8 46042.3 46064.8 46185.0 8021.0 8987.0 9133.9 9134.7 10536.3 10383.0 10790.9 10830.6 10837.0 10845.9 10825.9 10901.4 10919.7 10921.1 10923.6 10766.2 10768.4 10830.9 10846.0 10851.7 10725.8 10818.7 10822.5 10826.3 10827.9 42844.8 43172.6 43225.6 43271.0 43309.1 3604.8 3668.7 3782.8 4056.4 4139.6 31749.2 31915.2 32104.7 32254.5 33446.0 4381.7 4468.3 4513.2 4620.4 4655.5 347181.0 347683.0 348129.0 348561.0 348574.0 58686.7 59345.7 59535.4 59604.1 59611.7 61197.0 61412.7 61483.0 61521.7 61532.7 17149.1 17427.0 17427.9 17437.6 17441.0 11999.6 13176.2 13406.5 13543.1 13551.9 17684.6 17721.0 17861.6 17893.1 18099.6 5741.1 5805.7 5859.1 5917.4 5985.3 922.7 971.2 987.8 989.4 1000.9 31462.7 31979.4 32123.0 32238.4 32378.2 1074.3 1115.0 1121.8 1128.2 1129.5 15979.9 16794.8 16956.9 16969.2 17272.8 494207.0 497052.0 498027.0 498577.0 498630.0 57866.0 57880.4 58039.1 58072.4 58262.0 1207.5 1273.5 1337.6 1338.4 1353.1 30671.0 31509.5 31982.7 32583.3 33312.8 55633.7 56298.2 56346.0 56358.4 56405.4 440661.0 440724.0 441309.0 441850.0 443947.0 27610.9 28695.3 28749.4 29745.6 29816.1 47124.0 47474.8 47681.5 47880.8 49327.0 39714.4 40007.2 40374.4 40787.4 42086.6 38599.6 39243.6 39376.4 40924.8 41652.4 37439.6 40736.0 42109.0 42138.8 42251.6 32360.8 36664.6 36995.0 37054.1 37529.4 27575.9 27646.6 27766.4 28178.0 28269.0 23:43:24 INFO - PROCESS | 20090 | 23:43:24 INFO - PROCESS | 20090 | [#2] jquery.html Cycles:180 Average:29603.71 Median:400.21 stddev:82522.18 (20619.7%) stddev-sans-first:82724.48 23:43:24 INFO - PROCESS | 20090 | Values: 368.9 386.5 397.5 402.9 419.4 16425.4 19192.0 19464.3 19551.7 20032.2 15447.0 15765.3 15777.8 17605.5 19375.3 5595.8 5633.9 5818.8 5830.4 5831.9 5716.4 5762.4 5812.2 5816.3 5824.4 5590.1 5648.2 5800.9 5803.4 5806.8 5702.0 5738.4 5745.5 5746.5 5752.1 4966.1 5123.6 5155.3 5164.9 5167.3 23136.2 23192.1 23261.9 23303.2 23425.2 2173.6 2933.1 3053.2 3065.1 3071.2 12957.0 13668.9 14302.1 14360.2 14476.6 1885.5 1924.6 1947.2 1979.8 2018.9 83480.6 84529.6 87232.6 87411.0 89089.0 10925.6 11269.6 11302.2 11303.5 11471.5 15962.4 16028.3 16039.7 16049.8 16064.3 8189.9 8191.2 8489.0 8502.0 8528.7 7692.3 7709.5 7768.6 7971.4 8008.0 4622.5 4639.3 4732.0 4864.3 5010.1 1935.5 1991.5 2026.0 2036.6 2048.9 840.6 941.7 957.0 965.8 1070.7 19647.6 20139.4 20268.8 20359.6 20396.2 935.9 948.8 963.8 973.8 1009.3 10371.2 10764.8 11008.7 11025.4 11056.4 490955.0 498958.0 501416.0 501488.0 505660.0 92139.5 92848.5 95691.5 96388.5 97003.0 968.4 1019.4 1023.9 1077.4 1078.7 16512.9 17114.3 17725.8 17763.3 17858.5 44034.5 44349.9 44584.0 44629.3 46549.0 56153.4 57431.4 59571.0 59691.0 60339.0 8342.7 8535.3 8538.2 8836.2 9090.0 7613.6 8188.7 8603.9 11130.7 13507.4 11729.2 11750.2 11904.2 11913.4 12491.8 11606.4 11812.0 11955.5 12108.8 12160.8 11305.3 11693.4 11768.1 12370.6 12510.6 7422.3 7587.1 7684.8 7869.6 7962.0 10109.6 11763.6 11857.8 11865.9 11991.5 23:43:24 INFO - PROCESS | 20090 | 23:43:24 INFO - PROCESS | 20090 | [#3] mootools.html Cycles:180 Average:5685.12 Median:4958.66 stddev:3230.42 (65.1%) stddev-sans-first:3221.82 23:43:24 INFO - PROCESS | 20090 | Values: 1189.6 1440.8 1484.4 1526.3 1722.1 8369.5 8829.1 8878.0 8878.9 8891.3 8642.8 8747.0 8759.8 8766.2 8826.3 2074.9 2382.7 2413.2 2457.8 2462.2 2437.5 2458.4 2467.4 2472.7 2480.0 2351.3 2370.8 2389.1 2392.5 2429.9 2286.7 2355.2 2391.9 2397.9 2400.1 2374.3 2386.9 2394.1 2394.6 2395.4 8743.3 8787.7 8788.0 8798.4 8834.5 5181.3 5204.5 5348.5 5351.0 5359.7 3387.0 3480.0 3492.5 3559.3 3560.2 1183.2 1250.8 1251.3 1267.1 1281.1 11887.3 11973.2 12055.0 12061.3 12062.1 4269.0 4461.6 4620.1 4628.4 4643.9 9604.6 9615.7 9617.5 9629.5 9631.1 5250.0 5257.2 5257.6 5259.6 5261.2 4268.7 4796.3 4812.8 4919.5 4928.8 3723.3 3808.4 3828.1 3878.8 3990.5 1152.3 1162.0 1166.8 1173.6 1174.8 788.6 811.6 902.7 943.8 948.1 5717.5 5718.1 5728.2 5787.7 6009.4 456.3 463.7 466.6 469.6 472.5 3957.7 3984.9 4008.9 4016.1 4024.4 10542.7 10895.3 10950.8 10974.5 11003.1 10824.8 10826.7 10875.7 10889.1 10911.2 8106.8 8155.6 8161.0 8172.7 8180.6 5513.0 5560.2 5575.9 5718.4 5759.8 9832.0 9902.2 9944.4 9965.5 9975.5 9383.1 9619.4 9745.9 9885.5 10086.3 6921.8 7143.5 7149.1 7718.6 7800.6 7777.2 8191.9 8404.4 8467.0 8634.3 7395.4 7414.6 7566.8 7664.2 7699.3 7273.6 7346.9 7495.5 7536.7 7832.7 6681.1 6836.7 6840.6 6854.9 6856.4 4790.9 4924.8 4951.1 4966.2 4995.9 4862.7 4887.9 5000.5 5045.8 5068.9 23:43:24 INFO - PROCESS | 20090 | 23:43:24 INFO - PROCESS | 20090 | [#4] prototype.html Cycles:180 Average:4584.26 Median:5116.85 stddev:1332.20 (26.0%) stddev-sans-first:1296.73 23:43:24 INFO - PROCESS | 20090 | Values: 309.9 333.5 334.8 338.5 338.9 5200.3 5281.6 5300.5 5310.4 5347.8 5190.5 5239.5 5242.2 5246.4 5254.8 4125.4 4159.5 4159.9 4173.5 4182.7 4027.5 4123.9 4127.9 4136.7 4138.9 4111.8 4132.0 4138.3 4143.5 4148.2 4124.0 4133.9 4134.7 4152.3 4168.1 3703.7 3720.1 3720.2 3723.1 3752.9 5031.3 5152.7 5160.9 5161.7 5179.8 4733.7 4751.0 4778.4 4784.1 4785.7 5353.7 5470.6 5486.9 5497.2 5500.8 4006.0 4011.4 4024.2 4029.7 4036.1 5433.8 5500.1 5704.8 5714.7 5718.2 4118.3 4118.3 4158.3 4159.6 4169.9 4168.8 4172.1 4193.6 4205.4 4219.4 4532.6 4772.8 4777.1 4780.7 4794.5 5494.7 5522.8 5535.6 5546.9 5590.9 1445.5 1457.9 1458.3 1459.6 1461.5 919.0 949.4 954.1 965.5 967.9 4720.6 4746.3 4748.7 4784.6 4793.5 4955.8 4979.9 5012.8 5021.6 5037.1 4554.5 4602.6 4767.0 4787.3 4806.6 2650.8 2656.6 2657.7 2660.3 2661.1 5086.7 5111.7 5122.0 5131.8 5139.5 5056.7 5086.9 5087.0 5369.6 5828.0 5829.4 5865.7 5869.3 5883.5 5892.9 5660.1 5670.5 5675.1 5694.8 5696.5 5496.8 5663.5 5684.9 5704.8 5724.2 5609.4 5723.5 5783.7 5819.8 5869.3 4011.2 4047.0 4056.8 4099.7 4108.9 5634.6 5751.2 5771.1 5774.2 5774.8 5497.8 5505.2 5511.9 5559.3 5584.9 5508.3 5541.8 5545.8 5585.0 5591.0 5378.7 5502.8 5524.9 5529.4 5553.8 5468.8 5533.1 5542.4 5557.9 5596.2 5435.4 5438.4 5495.5 5497.3 5497.8 23:43:24 INFO - PROCESS | 20090 | 23:43:24 INFO - PROCESS | 20090 | [#5] yui.html Cycles:180 Average:20059.96 Median:4810.22 stddev:28281.49 (587.9%) stddev-sans-first:28323.73 23:43:24 INFO - PROCESS | 20090 | Values: 769.0 784.9 831.2 842.5 844.6 15414.2 16869.2 16869.6 16902.2 16933.4 14654.6 14700.1 14731.6 14737.8 14756.9 634.6 747.0 751.2 759.9 770.7 770.4 771.1 771.4 777.4 778.0 826.1 829.1 829.9 830.1 830.1 666.4 815.4 815.9 816.8 817.1 587.3 602.0 602.6 602.9 605.0 14693.9 14755.4 14777.6 14783.9 14784.0 13096.9 13412.8 13913.1 13989.7 14123.5 13153.7 13399.1 13463.3 13472.0 13677.7 4491.7 4546.8 4552.7 4562.0 4571.2 79014.0 79301.0 79391.6 80820.0 85638.6 11417.8 11566.6 11953.7 12078.0 12115.9 21189.5 21546.4 21605.6 21621.7 21692.7 8653.1 8740.8 8826.6 9059.5 9072.0 4765.8 4806.4 4815.9 4950.3 4958.8 3225.7 3427.5 3427.8 3447.2 3458.7 561.6 564.2 575.6 587.1 587.9 651.3 659.5 668.3 693.3 704.5 9057.3 9665.6 9807.2 9833.5 9837.0 616.2 667.5 668.7 688.4 717.8 4323.4 4632.4 4652.7 4705.3 4814.1 70508.0 78378.6 88381.6 125864.4 126456.0 85941.6 86850.6 87625.6 108065.0 108784.0 55962.7 70466.6 84599.0 86258.1 87473.0 9637.6 10124.1 10446.2 10497.3 10519.8 38643.8 49495.3 49522.5 49698.0 50545.0 66307.7 74771.6 76386.0 76744.0 80902.0 12530.2 12696.9 12927.8 13134.7 13201.2 15123.3 15296.5 15442.3 15681.5 15719.4 12098.0 12530.9 14457.6 14697.2 14878.5 13008.2 13025.4 13357.6 13412.6 13867.2 12504.0 12834.2 13151.9 13476.3 13581.3 9897.6 9927.6 9962.5 10073.6 10266.7 9644.8 10450.5 10490.4 10765.8 11823.4 23:43:24 INFO - PROCESS | 20090 | -------- Summary: end -------- 23:43:24 INFO - PROCESS | 20090 | 23:43:25 INFO - TEST-INFO | 20090: exit 0 23:43:25 INFO - TEST-OK | dromaeo_css | took 1116255ms 23:43:25 INFO - TEST-START | kraken 23:43:25 INFO - operating with platform_type : linux_ 23:43:25 INFO - Initialising browser for kraken test... 23:43:25 INFO - TEST-INFO | started process 20394 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjAXstu/profile http://localhost:40978/getInfo.html) 23:43:29 INFO - PROCESS | 20394 | __metrics Screen width/height:1600/1200 23:43:29 INFO - PROCESS | 20394 | colorDepth:24 23:43:29 INFO - PROCESS | 20394 | Browser inner width/height: 1024/697 23:43:29 INFO - PROCESS | 20394 | __metrics 23:43:29 INFO - PROCESS | 20394 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 23:43:29 INFO - PROCESS | 20394 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:43:30 INFO - PROCESS | 20394 | console.error: PushService: 23:43:30 INFO - PROCESS | 20394 | stateChangeProcessEnqueue: Error transitioning state 23:43:30 INFO - PROCESS | 20394 | UnknownError 23:43:31 INFO - TEST-INFO | 20394: exit 0 23:43:31 INFO - Browser initialized. 23:43:31 INFO - Running cycle 1/1 for kraken test... 23:43:31 INFO - TEST-INFO | started process 20474 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjAXstu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:43:43 INFO - PROCESS | 20474 | RSS: Main: 179453952 23:43:43 INFO - PROCESS | 20474 | 23:43:45 INFO - PROCESS | 20474 | Cycle 1(1): loaded http://localhost:40978/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40978/tests/kraken/driver.html?testName=audio-beat-detection) 23:43:46 INFO - PROCESS | 20474 | RSS: Main: 242630656 23:43:46 INFO - PROCESS | 20474 | 23:43:49 INFO - PROCESS | 20474 | Cycle 1(1): loaded http://localhost:40978/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40978/tests/kraken/driver.html?testName=audio-dft) 23:43:49 INFO - PROCESS | 20474 | RSS: Main: 224100352 23:43:49 INFO - PROCESS | 20474 | 23:43:52 INFO - PROCESS | 20474 | Cycle 1(1): loaded http://localhost:40978/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40978/tests/kraken/driver.html?testName=audio-fft) 23:43:53 INFO - PROCESS | 20474 | RSS: Main: 301322240 23:43:53 INFO - PROCESS | 20474 | 23:43:55 INFO - PROCESS | 20474 | Cycle 1(1): loaded http://localhost:40978/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40978/tests/kraken/driver.html?testName=audio-oscillator) 23:43:56 INFO - PROCESS | 20474 | RSS: Main: 212058112 23:43:56 INFO - PROCESS | 20474 | 23:43:58 INFO - PROCESS | 20474 | Cycle 1(1): loaded http://localhost:40978/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40978/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:43:58 INFO - PROCESS | 20474 | RSS: Main: 214409216 23:43:58 INFO - PROCESS | 20474 | 23:44:01 INFO - PROCESS | 20474 | Cycle 1(1): loaded http://localhost:40978/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40978/tests/kraken/driver.html?testName=imaging-darkroom) 23:44:02 INFO - PROCESS | 20474 | RSS: Main: 252837888 23:44:02 INFO - PROCESS | 20474 | 23:44:05 INFO - PROCESS | 20474 | Cycle 1(1): loaded http://localhost:40978/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40978/tests/kraken/driver.html?testName=imaging-desaturate) 23:44:06 INFO - PROCESS | 20474 | RSS: Main: 252104704 23:44:06 INFO - PROCESS | 20474 | 23:44:09 INFO - PROCESS | 20474 | Cycle 1(1): loaded http://localhost:40978/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40978/tests/kraken/driver.html?testName=json-parse-financial) 23:44:09 INFO - PROCESS | 20474 | RSS: Main: 251920384 23:44:09 INFO - PROCESS | 20474 | 23:44:11 INFO - PROCESS | 20474 | Cycle 1(1): loaded http://localhost:40978/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40978/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:44:12 INFO - PROCESS | 20474 | RSS: Main: 214200320 23:44:12 INFO - PROCESS | 20474 | 23:44:13 INFO - PROCESS | 20474 | Cycle 1(1): loaded http://localhost:40978/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40978/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:44:14 INFO - PROCESS | 20474 | RSS: Main: 221573120 23:44:14 INFO - PROCESS | 20474 | 23:44:16 INFO - PROCESS | 20474 | Cycle 1(1): loaded http://localhost:40978/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40978/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:44:17 INFO - PROCESS | 20474 | RSS: Main: 222728192 23:44:17 INFO - PROCESS | 20474 | 23:44:19 INFO - PROCESS | 20474 | Cycle 1(1): loaded http://localhost:40978/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40978/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:44:20 INFO - PROCESS | 20474 | RSS: Main: 223559680 23:44:20 INFO - PROCESS | 20474 | 23:44:23 INFO - PROCESS | 20474 | Cycle 1(1): loaded http://localhost:40978/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40978/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:44:23 INFO - PROCESS | 20474 | RSS: Main: 221487104 23:44:23 INFO - PROCESS | 20474 | 23:44:25 INFO - PROCESS | 20474 | Cycle 1(1): loaded http://localhost:40978/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40978/tests/kraken/driver.html?testName=ai-astar) 23:44:25 INFO - PROCESS | 20474 | RSS: Main: 272506880 23:44:25 INFO - PROCESS | 20474 | 23:44:25 INFO - PROCESS | 20474 | __start_tp_report 23:44:25 INFO - PROCESS | 20474 | _x_x_mozilla_page_load 23:44:25 INFO - PROCESS | 20474 | _x_x_mozilla_page_load_details 23:44:25 INFO - PROCESS | 20474 | |i|pagename|runs| 23:44:25 INFO - PROCESS | 20474 | |0;ai-astar;112;113;119;114;112;113;113;113;111;127 23:44:25 INFO - PROCESS | 20474 | |1;audio-beat-detection;143;119;150;185;121;146;152;120;172;123 23:44:25 INFO - PROCESS | 20474 | |2;audio-dft;161;160;162;162;161;163;162;163;161;162 23:44:25 INFO - PROCESS | 20474 | |3;audio-fft;75;75;76;169;76;76;77;77;184;76 23:44:25 INFO - PROCESS | 20474 | |4;audio-oscillator;82;82;150;82;83;83;141;82;82;146 23:44:25 INFO - PROCESS | 20474 | |5;imaging-gaussian-blur;117;117;120;117;117;118;119;118;117;117 23:44:25 INFO - PROCESS | 20474 | |6;imaging-darkroom;146;146;146;147;146;145;145;145;145;145 23:44:25 INFO - PROCESS | 20474 | |7;imaging-desaturate;94;96;95;96;96;95;95;95;95;95 23:44:25 INFO - PROCESS | 20474 | |8;json-parse-financial;51;51;51;52;51;51;52;53;52;52 23:44:25 INFO - PROCESS | 20474 | |9;json-stringify-tinderbox;60;61;60;61;62;60;61;61;61;62 23:44:25 INFO - PROCESS | 20474 | |10;stanford-crypto-aes;82;83;80;81;79;81;79;78;79;88 23:44:25 INFO - PROCESS | 20474 | |11;stanford-crypto-ccm;126;124;130;131;131;130;124;122;172;130 23:44:25 INFO - PROCESS | 20474 | |12;stanford-crypto-pbkdf2;175;166;167;164;170;164;167;167;167;162 23:44:25 INFO - PROCESS | 20474 | |13;stanford-crypto-sha256-iterative;66;65;66;65;65;65;64;66;64;64 23:44:25 INFO - PROCESS | 20474 | __end_tp_report 23:44:25 INFO - PROCESS | 20474 | __start_cc_report 23:44:25 INFO - PROCESS | 20474 | _x_x_mozilla_cycle_collect,1717 23:44:25 INFO - PROCESS | 20474 | __end_cc_report 23:44:25 INFO - PROCESS | 20474 | __startTimestamp1472798665696__endTimestamp 23:44:25 INFO - PROCESS | 20474 | 23:44:25 INFO - PROCESS | 20474 | ------- Summary: start ------- 23:44:25 INFO - PROCESS | 20474 | Number of tests: 14 23:44:25 INFO - PROCESS | 20474 | 23:44:25 INFO - PROCESS | 20474 | [#0] ai-astar Cycles:10 Average:114.70 Median:113.00 stddev:4.83 (4.3%) stddev-sans-first:5.02 23:44:25 INFO - PROCESS | 20474 | Values: 112.0 113.0 119.0 114.0 112.0 113.0 113.0 113.0 111.0 127.0 23:44:25 INFO - PROCESS | 20474 | 23:44:25 INFO - PROCESS | 20474 | [#1] audio-beat-detection Cycles:10 Average:143.10 Median:148.00 stddev:22.93 (15.5%) stddev-sans-first:24.32 23:44:25 INFO - PROCESS | 20474 | Values: 143.0 119.0 150.0 185.0 121.0 146.0 152.0 120.0 172.0 123.0 23:44:25 INFO - PROCESS | 20474 | 23:44:25 INFO - PROCESS | 20474 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.95 (0.6%) stddev-sans-first:0.97 23:44:25 INFO - PROCESS | 20474 | Values: 161.0 160.0 162.0 162.0 161.0 163.0 162.0 163.0 161.0 162.0 23:44:25 INFO - PROCESS | 20474 | 23:44:25 INFO - PROCESS | 20474 | [#3] audio-fft Cycles:10 Average:96.10 Median:76.00 stddev:42.53 (56.0%) stddev-sans-first:44.42 23:44:25 INFO - PROCESS | 20474 | Values: 75.0 75.0 76.0 169.0 76.0 76.0 77.0 77.0 184.0 76.0 23:44:25 INFO - PROCESS | 20474 | 23:44:25 INFO - PROCESS | 20474 | [#4] audio-oscillator Cycles:10 Average:101.30 Median:82.00 stddev:30.69 (37.4%) stddev-sans-first:31.75 23:44:25 INFO - PROCESS | 20474 | Values: 82.0 82.0 150.0 82.0 83.0 83.0 141.0 82.0 82.0 146.0 23:44:25 INFO - PROCESS | 20474 | 23:44:25 INFO - PROCESS | 20474 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:117.50 stddev:1.06 (0.9%) stddev-sans-first:1.09 23:44:25 INFO - PROCESS | 20474 | Values: 117.0 117.0 120.0 117.0 117.0 118.0 119.0 118.0 117.0 117.0 23:44:25 INFO - PROCESS | 20474 | 23:44:25 INFO - PROCESS | 20474 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 23:44:25 INFO - PROCESS | 20474 | Values: 146.0 146.0 146.0 147.0 146.0 145.0 145.0 145.0 145.0 145.0 23:44:25 INFO - PROCESS | 20474 | 23:44:25 INFO - PROCESS | 20474 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.50 23:44:25 INFO - PROCESS | 20474 | Values: 94.0 96.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 23:44:25 INFO - PROCESS | 20474 | 23:44:25 INFO - PROCESS | 20474 | [#8] json-parse-financial Cycles:10 Average:51.60 Median:52.00 stddev:0.70 (1.3%) stddev-sans-first:0.71 23:44:25 INFO - PROCESS | 20474 | Values: 51.0 51.0 51.0 52.0 51.0 51.0 52.0 53.0 52.0 52.0 23:44:25 INFO - PROCESS | 20474 | 23:44:25 INFO - PROCESS | 20474 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 23:44:25 INFO - PROCESS | 20474 | Values: 60.0 61.0 60.0 61.0 62.0 60.0 61.0 61.0 61.0 62.0 23:44:25 INFO - PROCESS | 20474 | 23:44:25 INFO - PROCESS | 20474 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:81.00 stddev:2.91 (3.6%) stddev-sans-first:3.06 23:44:25 INFO - PROCESS | 20474 | Values: 82.0 83.0 80.0 81.0 79.0 81.0 79.0 78.0 79.0 88.0 23:44:25 INFO - PROCESS | 20474 | 23:44:25 INFO - PROCESS | 20474 | [#11] stanford-crypto-ccm Cycles:10 Average:132.00 Median:130.00 stddev:14.45 (11.1%) stddev-sans-first:15.16 23:44:25 INFO - PROCESS | 20474 | Values: 126.0 124.0 130.0 131.0 131.0 130.0 124.0 122.0 172.0 130.0 23:44:25 INFO - PROCESS | 20474 | 23:44:25 INFO - PROCESS | 20474 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.90 Median:167.00 stddev:3.60 (2.2%) stddev-sans-first:2.35 23:44:25 INFO - PROCESS | 20474 | Values: 175.0 166.0 167.0 164.0 170.0 164.0 167.0 167.0 167.0 162.0 23:44:25 INFO - PROCESS | 20474 | 23:44:25 INFO - PROCESS | 20474 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:65.00 stddev:0.82 (1.3%) stddev-sans-first:0.78 23:44:25 INFO - PROCESS | 20474 | Values: 66.0 65.0 66.0 65.0 65.0 65.0 64.0 66.0 64.0 64.0 23:44:25 INFO - PROCESS | 20474 | -------- Summary: end -------- 23:44:25 INFO - PROCESS | 20474 | 23:44:26 INFO - TEST-INFO | 20474: exit 0 23:44:26 INFO - TEST-OK | kraken | took 61858ms 23:44:26 INFO - SUITE-END | took 1178s 23:44:27 INFO - Completed test suite (00:19:38) 23:44:27 INFO - javascript benchmark 23:44:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3001.6998300169985, 3009.98495007525, 3034.9999999999986, 3048.0551029180942, 3086.9536956945635, 5153.613478989077, 5205.479452054793, 5237.3453318335205, 5269.367675878895, 5277.551408130314, 5237.135872581029, 5254.343207099113, 5311.760970756325, 5333.813316533922, 5337.626366154371, 4718.834840780573, 4818.445878723956, 4819.951800482003, 4823.155947709137, 4974.477679843619, 4885.5114488551035, 4916.287138364935, 4947.233178857283, 4959.652824302282, 4972.279019542164, 4669.766511674419, 4723.976380118112, 4762.595179409755, 4790.520947905182, 4869.634777391692, 4795.424549054101, 4800.495947925488, 4854.805807767685, 4863.732494712789, 4875.976045030512, 4728.574428301469, 4758.072175925696, 4767.666263361566, 4777.95222047782, 4830.758462076882, 5193.298904647862, 5199.0, 5246.868828279324, 5307.177387504943, 5312.574994000471, 5565.332160140769, 5609.803656872031, 5616.213730077792, 5663.065594176997, 5674.9716251418895, 5629.915551266734, 5648.717564121818, 5650.434956504317, 5652.34997975234, 5655.915161272585, 5154.742262886841, 5193.0, 5251.396089449724, 5253.6322457428, 5255.343082114736, 5634.098544232903, 5678.77284908599, 5678.858028549319, 5741.712914354265, 5749.741261643236, 5450.672959622435, 5465.726713664301, 5502.669839809624, 5535.750891209906, 5538.9169162462595, 5459.181122831607, 5477.67133971963, 5529.834104976857, 5537.556995440355, 5547.11246200606, 5561.332640083216, 5603.215549823028, 5612.354579223442, 5661.122526008476, 5668.376478587352, 5575.581831362664, 5600.5799565032785, 5608.383077861432, 5608.663480191201, 5614.719264036782, 4307.870763877026, 4378.562143785596, 4383.3863259143745, 4391.407160033418, 4443.289073748185, 3942.704297177723, 3947.151362457028, 3985.442038114666, 4015.6586690131667, 4025.879223623296, 5379.892402151935, 5381.354237491526, 5381.811636592701, 5382.327209098863, 5387.0, 5528.391876893619, 5532.3914369419335, 5736.282964629421, 5753.0, 5760.971195144081, 5041.143005689041, 5303.257543943851, 5305.0, 5345.518903298722, 5356.357237131491, 4804.879878003008, 4805.783739731721, 4811.109944660249, 4817.927731083966, 4865.318855360252, 5700.3444603871085, 5773.220615216976, 5783.913241301468, 5791.131330300489, 5802.448767367094, 5654.943450565442, 5683.516901063456, 5706.686132262599, 5766.452187042224, 5768.134779783066, 5818.44724751148, 5827.737751801264, 5838.474537291494, 5840.766369345349, 5841.50347220474, 5429.049916264717, 5565.081761509306, 5611.130274807411, 5611.971940140274, 5618.044932361427, 5654.15187721845, 5727.770889164387, 5729.828105156852, 5788.189653448437, 5798.420157984167, 5545.195946587803, 5565.526930210977, 5614.354349249888, 5618.157276408571, 5618.606697531297, 5436.6194366393975, 5484.61607687458, 5598.384177740364, 5609.691466969356, 5617.438256174513, 5467.808626698046, 5512.118061110203, 5514.641548299348, 5575.637583557056, 5575.8884822304135, 5593.748281327269, 5593.9440605595055, 5601.691906945157, 5602.047651899105, 5603.943960560342, 5361.035013697572, 5416.7020813855615, 5474.288342515448, 5487.862803429946, 5490.403257559592], "value": 5210.461273865082, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.5827445964446, 609.0377204017652, 616.9814905552829, 625.7403177681264, 632.2570979099556, 42472.0, 44262.77868610656, 44303.335449968275, 44420.33369499452, 47732.0, 45589.54410455895, 45611.77194114033, 46042.30936535955, 46064.76967615157, 46185.0, 8021.0, 8987.0, 9133.862992055092, 9134.680286189985, 10536.315139515946, 10383.0, 10790.946045269802, 10830.566777328937, 10837.0, 10845.945770271137, 10825.945870270638, 10901.400422976732, 10919.672409827677, 10921.12630989519, 10923.563057477691, 10766.24636275461, 10768.407737574431, 10830.891691083107, 10846.023857852831, 10851.67444976652, 10725.785484290349, 10818.72953176169, 10822.458877056195, 10826.296290741077, 10827.945860270727, 42844.78577607123, 43172.56827431717, 43225.56774432247, 43271.0, 43309.13381732379, 3604.8017359045243, 3668.724845636588, 3782.7919464429447, 4056.391541268804, 4139.606737359946, 31749.20626984344, 31915.202119946956, 32104.6789532104, 32254.516182257285, 33446.0, 4381.715188512769, 4468.262736648449, 4513.232750432434, 4620.445546534404, 4655.4878963314, 347181.0, 347683.0, 348129.0, 348561.0, 348574.0, 58686.70656646689, 59345.70327148423, 59535.404645952985, 59604.10593841096, 59611.70194149001, 61197.0, 61412.69293653503, 61483.0, 61521.692391537756, 61532.69233653803, 17149.056801876017, 17427.041512716667, 17427.912860435616, 17437.564060898578, 17441.0, 11999.580014699444, 13176.209427434385, 13406.463741450429, 13543.119697219649, 13551.932240338736, 17684.557886052695, 17721.0, 17861.553461163574, 17893.10534473271, 18099.63800723978, 5741.138829175574, 5805.66954482672, 5859.121131830174, 5917.378675239124, 5985.25184351956, 922.686286662538, 971.2036130373026, 987.7678745494803, 989.4162444157837, 1000.8548760429696, 31462.685373146433, 31979.360412791615, 32123.0, 32238.35523289521, 32378.190545236088, 1074.3285446595878, 1114.9832752508719, 1121.8092924202906, 1128.15388458656, 1129.4747942206914, 15979.920100399424, 16794.832051679572, 16956.915215423844, 16969.15154242283, 17272.827271727372, 494207.0, 497052.0, 498027.0, 498577.0, 498630.0, 57866.0, 57880.4211957875, 58039.129413058836, 58072.4192758067, 58262.0, 1207.486818102303, 1273.490603758504, 1337.612092493166, 1338.3977210255423, 1353.1069494134022, 30671.0, 31509.52735709012, 31982.6801731989, 32583.29792286388, 33312.83343583267, 55633.72183139058, 56298.155527667936, 56346.0, 56358.436415636956, 56405.43594564002, 440661.0, 440724.0, 441309.0, 441850.0, 443947.0, 27610.861945690143, 28695.282617934718, 28749.425011500072, 29745.553816692332, 29816.123903892356, 47124.0, 47474.762626186646, 47681.523184769096, 47880.76059619679, 49327.0, 39714.40428393519, 40007.1998560033, 40374.39438408485, 40787.38818917659, 42086.57913420827, 38599.61400386073, 39243.607563925136, 39376.40935385914, 40924.79537602293, 41652.375214371204, 37439.6256037447, 40736.0, 42109.0, 42138.78930605327, 42251.57748422476, 32360.83819580887, 36664.63335366719, 36995.0, 37054.09320213711, 37529.43705844469, 27575.86212069007, 27646.5853012209, 27766.44467110687, 28178.0, 28269.0], "value": 20565.331585416152, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.9040849379161, 386.4782543566188, 397.5051061428522, 402.9174019326038, 419.38930159755506, 16425.42511012115, 19192.0, 19464.318748843794, 19551.706724399144, 20032.198712051537, 15447.0, 15765.290561924712, 15777.842221577781, 17605.471835844914, 19375.32186373477, 5595.776168953247, 5633.887322253552, 5818.825435236929, 5830.4461076197695, 5831.883362332751, 5716.428357164292, 5762.366139724627, 5812.186293918855, 5816.33112192097, 5824.388439213864, 5590.105583106703, 5648.15277708345, 5800.854978625547, 5803.419658034205, 5806.809604031185, 5701.971490142564, 5738.397468265855, 5745.511631511326, 5746.454086861741, 5752.050911599602, 4966.106100901836, 5123.590112790967, 5155.304033955443, 5164.948350516484, 5167.250748641426, 23136.190233341753, 23192.072317107464, 23261.88369058161, 23303.184388546488, 23425.180118695935, 2173.608750424923, 2933.149386677861, 3053.206166396753, 3065.111117775842, 3071.2014876132143, 12957.0, 13668.93165534176, 14302.070365426214, 14360.210188439632, 14476.565703028926, 1885.4909174522938, 1924.6246981838547, 1947.191915355126, 1979.7822239553639, 2018.8687735297158, 83480.58259708724, 84529.57735211284, 87232.56383718167, 87411.0, 89089.0, 10925.617603383844, 11269.605563805228, 11302.208845380908, 11303.491342889425, 11471.483783229774, 15962.441314553935, 16028.278727457293, 16039.679206415807, 16049.759253611206, 16064.27710753019, 8189.918100819034, 8191.221833925768, 8489.0, 8501.957490212633, 8528.701495447629, 7692.269234422721, 7709.537427754352, 7768.572728499987, 7971.40214483916, 8008.039035315799, 4622.491525932145, 4639.280911458729, 4731.976340118346, 4864.318995340655, 5010.073136469765, 1935.5451468904796, 1991.4722598511405, 2025.9594808103755, 2036.5926814637132, 2048.897555122238, 840.6385254340693, 941.7363138321281, 956.9712908612753, 965.7730433348157, 1070.7483741320784, 19647.607047858965, 20139.39581812548, 20268.79731202669, 20359.592808143756, 20396.184152633727, 935.8689783430189, 948.8244674735196, 963.8457846744487, 973.7808992976524, 1009.3136667066466, 10371.222158338154, 10764.838527422095, 11008.669739907655, 11025.393603351893, 11056.447177641086, 490955.0, 498958.0, 501416.0, 501488.0, 505660.0, 92139.53930230306, 92848.53575732213, 95691.52154239184, 96388.51805740927, 97003.0, 968.4431451915177, 1019.3527110284874, 1023.9436830974219, 1077.3535878472853, 1078.730317420645, 16512.917435413226, 17114.315427382764, 17725.822741772416, 17763.289468421117, 17858.46424607264, 44034.46983889097, 44349.89550731418, 44584.0, 44629.33056004097, 46549.0, 56153.43846561482, 57431.42568574261, 59571.0, 59691.0, 60339.0, 8342.749717508485, 8535.274501667427, 8538.231559159705, 8836.248918841713, 9090.045545217657, 7613.619319033915, 8188.672453102047, 8603.913960860562, 11130.666080017612, 13507.411995045524, 11729.237599556001, 11750.177487575787, 11904.226225295328, 11913.404329783649, 12491.75016499683, 11606.419679016184, 11812.0, 11955.462004209658, 12108.818367724314, 12160.817587736014, 11305.26515776472, 11693.356865372147, 11768.058555315383, 12370.62888113358, 12510.624681259576, 7422.257774222535, 7587.127480339611, 7684.8463030740195, 7869.606519674108, 7962.0, 10109.64616238428, 11763.647090587296, 11857.754935731624, 11865.881341186478, 11991.520339186683], "value": 9297.557053278115, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1189.6371606659966, 1440.7838824176372, 1484.4062375049982, 1526.2750193658007, 1722.0872937343204, 8369.539675317856, 8829.072947340534, 8878.023417424094, 8878.86681699775, 8891.33315001376, 8642.783930401743, 8746.956265218665, 8759.781005474866, 8766.167214114665, 8826.293896488281, 2074.8962551872423, 2382.6783384243167, 2413.191580820423, 2457.8156638252112, 2462.212092130519, 2437.4515733959893, 2458.360826185196, 2467.370820440794, 2472.666190064336, 2479.962800557984, 2351.329870986769, 2370.762923707624, 2389.104085967762, 2392.461696118377, 2429.8542087474807, 2286.7141607299086, 2355.1521452277166, 2391.9162829300976, 2397.8681172535503, 2400.1479474786547, 2374.2639781667567, 2386.9045238190624, 2394.1381102802975, 2394.628832530943, 2395.4370722880108, 8743.300535957173, 8787.692430764957, 8787.956060219658, 8798.384113112084, 8834.514101724402, 5181.326427564392, 5204.4535323791215, 5348.491893270133, 5351.036813373591, 5359.678419294816, 3386.9661303386897, 3480.042988178246, 3492.4935884296888, 3559.270349578356, 3560.2167523144867, 1183.1599564309352, 1250.7985944737236, 1251.330538162079, 1267.1383459247709, 1281.1288323939718, 11887.346195959219, 11973.221740586834, 12054.999999999913, 12061.276323420623, 12062.095342849234, 4269.0, 4461.643068554573, 4620.0990806793025, 4628.352030715702, 4643.883902902455, 9604.615815367308, 9615.711528654152, 9617.51912404377, 9629.518524073908, 9631.08504692053, 5250.0, 5257.185136303879, 5257.631965762436, 5259.552938000236, 5261.237120617489, 4268.701190916606, 4796.328514008042, 4812.759362031885, 4919.458859525449, 4928.827491037797, 3723.3484140275887, 3808.428735689669, 3828.062124779391, 3878.806059697004, 3990.541087774885, 1152.3028567716578, 1162.0471213604762, 1166.7899778040035, 1173.612707806422, 1174.7591743692522, 788.645109700637, 811.5860910935465, 902.6660135749814, 943.834828904939, 948.1419315519466, 5717.485426311652, 5718.1136923776885, 5728.198052272685, 5787.652740835563, 6009.429104235091, 456.27452350761786, 463.6777439679458, 466.55444050931277, 469.55861490199106, 472.47319239048903, 3957.742746721454, 3984.900377490586, 4008.9198216035516, 4016.0763024504527, 4024.396340548941, 10542.736431589272, 10895.346279223271, 10950.835737463944, 10974.506147223394, 11003.064739497233, 10824.78350432987, 10826.729331766612, 10875.67372978796, 10889.074428673493, 10911.181661375429, 8106.756797296091, 8155.592220389076, 8161.020677518736, 8172.67309307633, 8180.550069746221, 5512.972435137799, 5560.165975103605, 5575.944240557543, 5718.428157184248, 5759.819237056309, 9832.0, 9902.158316543175, 9944.403335799876, 9965.50172491358, 9975.50122493887, 9383.108604682544, 9619.422834629664, 9745.853812192965, 9885.456299903575, 10086.29395942277, 6921.826954326182, 7143.499955003308, 7149.070620819468, 7718.575478348745, 7800.570968596781, 7777.222277772177, 8191.877121843297, 8404.36967227448, 8467.026291976255, 8634.309255259439, 7395.408367330709, 7414.62926853666, 7566.772996810105, 7664.233576642514, 7699.30706236419, 7273.636318184175, 7346.926530734624, 7495.512791668524, 7536.7362142324755, 7832.725854595062, 6681.098051763144, 6836.726530938707, 6840.589564626139, 6854.897176542256, 6856.41720453767, 4790.880227994188, 4924.778384972613, 4951.1088004158155, 4966.205407134841, 4995.925061124159, 4862.7325497098, 4887.877803054952, 5000.524845170756, 5045.84862454127, 5068.898622027613], "value": 4489.3914601570605, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.9178717639826, 333.46978304495855, 334.80079352785083, 338.46353529655494, 338.852599119383, 5200.2719619253285, 5281.577473802096, 5300.496452836984, 5310.362756469224, 5347.786088556453, 5190.506901844328, 5239.502247286511, 5242.239875218091, 5246.396664383587, 5254.81608143715, 4125.443065186207, 4159.542450330461, 4159.92003998001, 4173.520045194811, 4182.707210495267, 4027.5166979962446, 4123.917521649565, 4127.855525056623, 4136.655586934244, 4138.875833724993, 4111.835526578933, 4131.9876630225635, 4138.255114079465, 4143.482064741907, 4148.170365926811, 4123.958760412403, 4133.91732165358, 4134.73124246923, 4152.314868046784, 4168.145530166309, 3703.7222208334215, 3720.144366795625, 3720.2001569662652, 3723.1250656095795, 3752.892896595511, 5031.345925029759, 5152.690838549662, 5160.92258616121, 5161.7161056141895, 5179.8446046618665, 4733.668643194977, 4750.976245118753, 4778.402699662543, 4784.138855006097, 4785.736784476852, 5353.732313384316, 5470.64440811346, 5486.945130548684, 5497.202905578709, 5500.834974950758, 4005.959940400588, 4011.3782363733667, 4024.1750441159493, 4029.738067025634, 4036.112055347848, 5433.782648694048, 5500.092484740053, 5704.80033198836, 5714.7428365723645, 5718.170865224519, 4118.279301122292, 4118.341065429577, 4158.272302347077, 4159.604837540429, 4169.874903752831, 4168.7707176105605, 4172.123853990635, 4193.622573968358, 4205.36919462077, 4219.38818871262, 4532.637389008872, 4772.832950846704, 4777.116233496814, 4780.665353425296, 4794.544518270759, 5494.697791621499, 5522.779088836402, 5535.5848311376, 5546.91679624806, 5590.888182236333, 1445.5302026841318, 1457.9052361596462, 1458.2927280269062, 1459.5548357750988, 1461.4592600737794, 919.0296389526471, 949.3639261694543, 954.0507195340681, 965.5365424596092, 967.9322447428754, 4720.622350211975, 4746.28805679144, 4748.691335063209, 4784.593309568726, 4793.544613261734, 4955.801767929314, 4979.90040199194, 5012.774425150877, 5021.648484606116, 5037.143685573461, 4554.453465584151, 4602.608778253886, 4766.95233047672, 4787.257975013878, 4806.615470762331, 2650.814442989011, 2656.6015097735494, 2657.6677915260593, 2660.2950218192195, 2661.0973154194844, 5086.745662716849, 5111.667741596784, 5122.026814905156, 5131.820386286462, 5139.45816255122, 5056.6713163644245, 5086.872828179251, 5086.974565127225, 5369.597280203922, 5827.970860145672, 5829.417058294137, 5865.709543900421, 5869.266341707286, 5883.529317654577, 5892.94107058924, 5660.122680984454, 5670.546356291405, 5675.148727690879, 5694.829155125353, 5696.458836410535, 5496.835094947158, 5663.518600918968, 5684.886302274014, 5704.828855134353, 5724.227229323988, 5609.411011843861, 5723.513501352431, 5783.7397317119985, 5819.76720931158, 5869.266341707286, 4011.2378648056774, 4046.9797651012736, 4056.797160141922, 4099.713020088565, 4108.938365924573, 5634.605577609528, 5751.223584815996, 5771.076627739541, 5774.220480235114, 5774.82675519735, 5497.8075767347955, 5505.229267902417, 5511.917321240265, 5559.27729395176, 5584.944150558605, 5508.283923089973, 5541.833744987657, 5545.833624991256, 5584.972075139598, 5591.0, 5378.650387724785, 5502.8349149525575, 5524.91712624319, 5529.4470552944385, 5553.834004738236, 5468.835934921959, 5533.059379905345, 5542.418046105101, 5557.916631250454, 5596.188552659923, 5435.429279925709, 5438.401775804738, 5495.53287970527, 5497.285352904097, 5497.752601132878], "value": 4163.353568738182, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [768.9769306920791, 784.9293563579278, 831.1646794971053, 842.528184216839, 844.6030365728105, 15414.15222162782, 16869.15654217289, 16869.57826054346, 16902.239399227034, 16933.391327823836, 14654.560363189095, 14700.117992920432, 14731.558053258392, 14737.778933315982, 14756.926215368909, 634.6160572853427, 746.9850602987937, 751.1887161865186, 759.9316061554459, 770.6994272233806, 770.3836930455641, 771.0631582627107, 771.4252881603186, 777.4324742937658, 777.9766607001799, 826.0747962282252, 829.1335554345693, 829.8921140251789, 830.1117803949776, 830.1325115254543, 666.4401902401958, 815.3803109636659, 815.9184081591852, 816.7590560784582, 817.0930267403178, 587.2805812879232, 602.0277252237648, 602.6474512410246, 602.9457348838582, 604.9576529642927, 14693.853061469463, 14755.409783608642, 14777.556673299818, 14783.852161478355, 14784.039037462639, 13096.86903130966, 13412.798808017887, 13913.095648782797, 13989.720205595933, 14123.505677301246, 13153.736925261537, 13399.06961949822, 13463.326833658279, 13472.0, 13677.726445471035, 4491.708038977456, 4546.772661366918, 4552.726836389827, 4562.0, 4571.1771881061395, 79014.0, 79301.0, 79391.60304198442, 80820.0, 85638.57180714118, 11417.771644567229, 11566.55418072741, 11953.701157471132, 12078.0, 12115.939420303019, 21189.470263243544, 21546.353609391743, 21605.567888642454, 21621.67567486489, 21692.674609880865, 8653.134686531297, 8740.825183496421, 8826.602802873886, 9059.501727405055, 9071.954640226757, 4765.833195838129, 4806.351142595705, 4815.903681926412, 4950.331705219821, 4958.752062396866, 3225.6774322567558, 3427.4516077427493, 3427.7600567960503, 3447.1899103710607, 3458.688718015391, 561.5844275236295, 564.1932037186862, 575.5609490316525, 587.0958723565747, 587.8647910980499, 651.3323843060806, 659.4954859532462, 668.3483603486659, 693.2616763147232, 704.4857254204358, 9057.320700947455, 9665.6380901272, 9807.166390856715, 9833.45915974614, 9837.0, 616.1558664629487, 667.5393978155057, 668.7091115364832, 688.4251649872413, 717.7846646006177, 4323.437953066082, 4632.3977882875015, 4652.744099074584, 4705.294205869079, 4814.085323788469, 70508.0, 78378.6081069591, 88381.55809221041, 125864.37067814785, 126456.0, 85941.5702921494, 86850.56574717212, 87625.56187219023, 108065.0, 108784.0, 55962.72018639881, 70466.64766676133, 84599.0, 86258.137418625, 87473.0, 9637.614495420105, 10124.13944814699, 10446.164306855586, 10497.317674351143, 10519.842202367123, 38643.80678096704, 49495.25757113718, 49522.50477495179, 49698.0, 50545.0, 66307.66846165931, 74771.62614186894, 76386.0, 76744.0, 80902.0, 12530.248185108923, 12696.936515317364, 12927.806082908575, 13134.737305254033, 13201.20792752438, 15123.319450624529, 15296.464623738117, 15442.30509627047, 15681.45114921018, 15719.371225150866, 12098.0, 12530.874691252971, 14457.566273011826, 14697.191654459108, 14878.479253226085, 13008.154469959421, 13025.413856376676, 13357.599272021855, 13412.597622071353, 13867.167969921837, 12504.0, 12834.16577922432, 13151.868481315447, 13476.258805765385, 13581.32093395346, 9897.55461004271, 9927.553260103168, 9962.452065136487, 10073.597056117673, 10266.691999240034, 9644.75888102803, 10450.454022760521, 10490.370577765358, 10765.784684306427, 11823.408829558659], "value": 7457.504209293116, "unit": "score"}], "name": "dromaeo_css", "value": 7196.293961648813, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 119.0, 114.0, 112.0, 113.0, 113.0, 113.0, 111.0, 127.0], "value": 114.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 119.0, 150.0, 185.0, 121.0, 146.0, 152.0, 120.0, 172.0, 123.0], "value": 143.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 162.0, 161.0, 163.0, 162.0, 163.0, 161.0, 162.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 169.0, 76.0, 76.0, 77.0, 77.0, 184.0, 76.0], "value": 96.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 150.0, 82.0, 83.0, 83.0, 141.0, 82.0, 82.0, 146.0], "value": 101.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 120.0, 117.0, 117.0, 118.0, 119.0, 118.0, 117.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 51.0, 52.0, 51.0, 51.0, 52.0, 53.0, 52.0, 52.0], "value": 51.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 61.0, 62.0, 60.0, 61.0, 61.0, 61.0, 62.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 80.0, 81.0, 79.0, 81.0, 79.0, 78.0, 79.0, 88.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 124.0, 130.0, 131.0, 131.0, 130.0, 124.0, 122.0, 172.0, 130.0], "value": 132.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 166.0, 167.0, 164.0, 170.0, 164.0, 167.0, 167.0, 167.0, 162.0], "value": 166.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 65.0, 65.0, 65.0, 64.0, 66.0, 64.0, 64.0], "value": 65.0, "unit": "score"}], "name": "kraken", "value": 1532.8000000000002, "alertThreshold": 2.0}]} 23:44:27 INFO - Return code: 0 23:44:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:44:27 INFO - # TBPL SUCCESS # 23:44:27 INFO - Running post-action listener: _resource_record_post_action 23:44:27 INFO - [mozharness: 2016-09-02 06:44:27.505851Z] Finished run-tests step (success) 23:44:27 INFO - Running post-run listener: _resource_record_post_run 23:44:27 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 423645184; Read time: 0; Write time: 333740 23:44:27 INFO - TinderboxPrint: CPU usage
13.1% 23:44:27 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 23:44:27 INFO - TinderboxPrint: I/O write bytes / time
423,645,184 / 333,740 23:44:27 INFO - TinderboxPrint: CPU idle
8,292.3 (86.9%) 23:44:27 INFO - TinderboxPrint: CPU user
1,200.1 (12.6%) 23:44:27 INFO - TinderboxPrint: Swap in / out
0 / 0 23:44:27 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 118472704; Read time: 0; Write time: 129204 23:44:27 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 288378880; Read time: 0; Write time: 200060 23:44:28 INFO - Running post-run listener: _upload_blobber_files 23:44:28 INFO - Blob upload gear active. 23:44:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:44:28 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 23:44:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:44:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:44:28 INFO - (blobuploader) - INFO - Open directory for files ... 23:44:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:44:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:44:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:44:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:44:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:44:29 INFO - (blobuploader) - INFO - Done attempting. 23:44:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:44:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:44:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:44:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:44:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:44:30 INFO - (blobuploader) - INFO - Done attempting. 23:44:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:44:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:44:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:44:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:44:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:44:33 INFO - (blobuploader) - INFO - Done attempting. 23:44:33 INFO - (blobuploader) - INFO - Iteration through files over. 23:44:33 INFO - Return code: 0 23:44:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:44:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:44:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0aa255e26e4edd0976a6d443d8cd7b6ffa51e87ba8f5b223d4c294025e81213ca76df294e7cf08c3e490749a5526177a833b4d4fb36aeb5324cba125b7b42b18", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4b8a1ffd269d2ee3870346a01cb25a1add1f5240f8342b55059bc34267515406eaacfce36151e1fe67b0f12c850a381baa4e759ba7a5cb329ff0f599a31dc363", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3401452fde9a2be12dc608f560acf6c4de95858d6225f2db9bacc8ad5a68c39aead87847b5963437afae2d2e614eb1ae998c53f3d9f76eca803b05a32f28d891"} 23:44:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:44:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:44:33 INFO - Contents: 23:44:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0aa255e26e4edd0976a6d443d8cd7b6ffa51e87ba8f5b223d4c294025e81213ca76df294e7cf08c3e490749a5526177a833b4d4fb36aeb5324cba125b7b42b18", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4b8a1ffd269d2ee3870346a01cb25a1add1f5240f8342b55059bc34267515406eaacfce36151e1fe67b0f12c850a381baa4e759ba7a5cb329ff0f599a31dc363", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3401452fde9a2be12dc608f560acf6c4de95858d6225f2db9bacc8ad5a68c39aead87847b5963437afae2d2e614eb1ae998c53f3d9f76eca803b05a32f28d891"} 23:44:33 INFO - Running post-run listener: copy_logs_to_upload_dir 23:44:33 INFO - Copying logs to upload dir... 23:44:33 INFO - mkdir: /builds/slave/test/build/upload/logs 23:44:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.492981 ========= master_lag: 0.15 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-09-01 23:44:33.553845) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 23:44:33.558424) ========= 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=337fe3f4b1febe37b85fccc40000019e-1472797235.716848-624849905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0aa255e26e4edd0976a6d443d8cd7b6ffa51e87ba8f5b223d4c294025e81213ca76df294e7cf08c3e490749a5526177a833b4d4fb36aeb5324cba125b7b42b18", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4b8a1ffd269d2ee3870346a01cb25a1add1f5240f8342b55059bc34267515406eaacfce36151e1fe67b0f12c850a381baa4e759ba7a5cb329ff0f599a31dc363", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3401452fde9a2be12dc608f560acf6c4de95858d6225f2db9bacc8ad5a68c39aead87847b5963437afae2d2e614eb1ae998c53f3d9f76eca803b05a32f28d891"} build_url:https://queue.taskcluster.net/v1/task/W10e_HY_Qua1LTWSUl876A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010385 build_url: 'https://queue.taskcluster.net/v1/task/W10e_HY_Qua1LTWSUl876A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0aa255e26e4edd0976a6d443d8cd7b6ffa51e87ba8f5b223d4c294025e81213ca76df294e7cf08c3e490749a5526177a833b4d4fb36aeb5324cba125b7b42b18", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4b8a1ffd269d2ee3870346a01cb25a1add1f5240f8342b55059bc34267515406eaacfce36151e1fe67b0f12c850a381baa4e759ba7a5cb329ff0f599a31dc363", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3401452fde9a2be12dc608f560acf6c4de95858d6225f2db9bacc8ad5a68c39aead87847b5963437afae2d2e614eb1ae998c53f3d9f76eca803b05a32f28d891"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 23:44:33.581896) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 23:44:33.585292) ========= 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=337fe3f4b1febe37b85fccc40000019e-1472797235.716848-624849905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004604 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 23:44:33.634582) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 23:44:33.634884) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 23:44:33.638246) ========= ========= Total master_lag: 0.29 =========