builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-031 starttime: 1472721650.82 results: success (0) buildid: 20160901012820 builduid: b08db1eff0204bbe9ff05da575f974fa revision: af5df7bd1d265bb95c76b69fa4fbcc60a84094f9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 02:20:50.823915) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 02:20:50.826965) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 02:20:50.827457) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 02:20:50.843860) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 02:20:50.844227) ========= 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=db0483c52d987ecb441a263b000001ad-1472721272.115553-159134206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-01 02:20:50-- 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% 874K=0.01s 2016-09-01 02:20:51 (874 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.138695 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 02:20:50.999373) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 02:20:50.999713) ========= 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=db0483c52d987ecb441a263b000001ad-1472721272.115553-159134206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023136 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 02:20:51.050225) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 02:20:51.050583) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev af5df7bd1d265bb95c76b69fa4fbcc60a84094f9 --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 af5df7bd1d265bb95c76b69fa4fbcc60a84094f9 --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=db0483c52d987ecb441a263b000001ad-1472721272.115553-159134206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-01 02:20:51,175 truncating revision to first 12 chars 2016-09-01 02:20:51,175 Setting DEBUG logging. 2016-09-01 02:20:51,175 attempt 1/10 2016-09-01 02:20:51,175 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/af5df7bd1d26?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-01 02:20:51,722 unpacking tar archive at: fx-team-af5df7bd1d26/testing/mozharness/ program finished with exit code 0 elapsedTime=0.889519 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 02:20:51.955737) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 02:20:51.956291) ========= script_repo_revision: af5df7bd1d265bb95c76b69fa4fbcc60a84094f9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 02:20:51.956855) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 02:20:51.957277) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 02:20:51.972182) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-09-01 02:20:51.972487) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db0483c52d987ecb441a263b000001ad-1472721272.115553-159134206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:20:52 INFO - MultiFileLogger online at 20160901 02:20:52 in /builds/slave/test 02:20:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 02:20:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:20:52 INFO - {'append_to_log': False, 02:20:52 INFO - 'base_work_dir': '/builds/slave/test', 02:20:52 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:20:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:20:52 INFO - 'branch': 'Fx-Team-Non-PGO', 02:20:52 INFO - 'buildbot_json_path': 'buildprops.json', 02:20:52 INFO - 'config_files': ('talos/linux_config.py',), 02:20:52 INFO - 'default_actions': ('clobber', 02:20:52 INFO - 'read-buildbot-config', 02:20:52 INFO - 'download-and-extract', 02:20:52 INFO - 'populate-webroot', 02:20:52 INFO - 'create-virtualenv', 02:20:52 INFO - 'install', 02:20:52 INFO - 'run-tests'), 02:20:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:20:52 INFO - 'download_minidump_stackwalk': True, 02:20:52 INFO - 'download_symbols': 'ondemand', 02:20:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:20:52 INFO - 'tooltool.py': '/tools/tooltool.py', 02:20:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:20:52 INFO - '/tools/misc-python/virtualenv.py')}, 02:20:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:20:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:20:52 INFO - 'installer_path': 'installer.exe', 02:20:52 INFO - 'log_level': 'info', 02:20:52 INFO - 'log_name': 'talos', 02:20:52 INFO - 'log_to_console': True, 02:20:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:20:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:20:52 INFO - 'opt_config_files': (), 02:20:52 INFO - 'pip_index': False, 02:20:52 INFO - 'sps_profile': False, 02:20:52 INFO - 'sps_profile_interval': 0, 02:20:52 INFO - 'suite': 'dromaeojs', 02:20:52 INFO - 'system_bits': '32', 02:20:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:20:52 INFO - 'title': 'talos-linux64-ix-031', 02:20:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:20:52 INFO - 'use_talos_json': True, 02:20:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:20:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:20:52 INFO - 'work_dir': 'build'} 02:20:52 INFO - [mozharness: 2016-09-01 09:20:52.194964Z] Running clobber step. 02:20:52 INFO - Running pre-action listener: _resource_record_pre_action 02:20:52 INFO - Running main action method: clobber 02:20:52 INFO - rmtree: /builds/slave/test/build 02:20:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:20:52 INFO - Running post-action listener: _resource_record_post_action 02:20:52 INFO - [mozharness: 2016-09-01 09:20:52.651197Z] Finished clobber step (success) 02:20:52 INFO - [mozharness: 2016-09-01 09:20:52.651299Z] Running read-buildbot-config step. 02:20:52 INFO - Running pre-action listener: _resource_record_pre_action 02:20:52 INFO - Running main action method: read_buildbot_config 02:20:52 INFO - Using buildbot properties: 02:20:52 INFO - { 02:20:52 INFO - "project": "", 02:20:52 INFO - "product": "firefox", 02:20:52 INFO - "script_repo_revision": "production", 02:20:52 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:20:52 INFO - "repository": "", 02:20:52 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 02:20:52 INFO - "buildid": "20160901012820", 02:20:52 INFO - "pgo_build": "False", 02:20:52 INFO - "basedir": "/builds/slave/test", 02:20:52 INFO - "buildnumber": 1911, 02:20:52 INFO - "slavename": "talos-linux64-ix-031", 02:20:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:20:52 INFO - "platform": "ubuntu64_hw", 02:20:52 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:20:52 INFO - "branch": "fx-team", 02:20:52 INFO - "repo_path": "integration/fx-team", 02:20:52 INFO - "revision": "af5df7bd1d265bb95c76b69fa4fbcc60a84094f9", 02:20:52 INFO - "stage_platform": "linux64", 02:20:52 INFO - "builduid": "b08db1eff0204bbe9ff05da575f974fa", 02:20:52 INFO - "slavebuilddir": "test" 02:20:52 INFO - } 02:20:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/b2BCI4rkSmiO8hQL-mCKjA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 02:20:52 INFO - Running post-action listener: _resource_record_post_action 02:20:52 INFO - [mozharness: 2016-09-01 09:20:52.653768Z] Finished read-buildbot-config step (success) 02:20:52 INFO - [mozharness: 2016-09-01 09:20:52.653858Z] Running download-and-extract step. 02:20:52 INFO - Running pre-action listener: _resource_record_pre_action 02:20:52 INFO - Running main action method: download_and_extract 02:20:52 INFO - mkdir: /builds/slave/test/build/tests 02:20:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:52 INFO - trying https://queue.taskcluster.net/v1/task/b2BCI4rkSmiO8hQL-mCKjA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 02:20:52 INFO - Downloading https://queue.taskcluster.net/v1/task/b2BCI4rkSmiO8hQL-mCKjA/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 02:20:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b2BCI4rkSmiO8hQL-mCKjA/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 02:20:53 INFO - Downloaded 1361 bytes. 02:20:53 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 02:20:53 INFO - Using the following test package requirements: 02:20:53 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 02:20:53 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:20:53 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:20:53 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:53 INFO - u'jsshell-linux-x86_64.zip'], 02:20:53 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:20:53 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 02:20:53 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:20:53 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:20:53 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:20:53 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:20:53 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:20:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:53 INFO - trying https://queue.taskcluster.net/v1/task/b2BCI4rkSmiO8hQL-mCKjA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 02:20:53 INFO - Downloading https://queue.taskcluster.net/v1/task/b2BCI4rkSmiO8hQL-mCKjA/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 02:20:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b2BCI4rkSmiO8hQL-mCKjA/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 02:20:53 INFO - Downloaded 20335243 bytes. 02:20:53 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 02:20:58 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 02:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:58 INFO - trying https://queue.taskcluster.net/v1/task/b2BCI4rkSmiO8hQL-mCKjA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 02:20:58 INFO - Downloading https://queue.taskcluster.net/v1/task/b2BCI4rkSmiO8hQL-mCKjA/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 02:20:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b2BCI4rkSmiO8hQL-mCKjA/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 02:20:59 INFO - Downloaded 20335243 bytes. 02:20:59 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 02:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:03 INFO - trying https://queue.taskcluster.net/v1/task/b2BCI4rkSmiO8hQL-mCKjA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 02:21:03 INFO - Downloading https://queue.taskcluster.net/v1/task/b2BCI4rkSmiO8hQL-mCKjA/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 02:21:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b2BCI4rkSmiO8hQL-mCKjA/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 02:21:04 INFO - Downloaded 14413998 bytes. 02:21:04 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 02:21:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:04 INFO - trying https://queue.taskcluster.net/v1/task/b2BCI4rkSmiO8hQL-mCKjA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:21:04 INFO - Downloading https://queue.taskcluster.net/v1/task/b2BCI4rkSmiO8hQL-mCKjA/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 02:21:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b2BCI4rkSmiO8hQL-mCKjA/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 02:21:06 INFO - Downloaded 55871240 bytes. 02:21:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b2BCI4rkSmiO8hQL-mCKjA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:21:06 INFO - mkdir: /builds/slave/test/properties 02:21:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:21:06 INFO - Writing to file /builds/slave/test/properties/build_url 02:21:06 INFO - Contents: 02:21:06 INFO - build_url:https://queue.taskcluster.net/v1/task/b2BCI4rkSmiO8hQL-mCKjA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:21:07 INFO - Running post-action listener: _resource_record_post_action 02:21:07 INFO - Running post-action listener: set_extra_try_arguments 02:21:07 INFO - [mozharness: 2016-09-01 09:21:07.636394Z] Finished download-and-extract step (success) 02:21:07 INFO - [mozharness: 2016-09-01 09:21:07.636622Z] Running populate-webroot step. 02:21:07 INFO - Running pre-action listener: _resource_record_pre_action 02:21:07 INFO - Running main action method: populate_webroot 02:21:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:21:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:21:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:21:07 INFO - '--tppagecycles', 02:21:07 INFO - '7'], 02:21:07 INFO - 'tests': ['tsvgm']}}, 02:21:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:21:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:21:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:21:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:21:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:21:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:21:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:21:07 INFO - 'talos_options': ['--disable-e10s'], 02:21:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:21:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:21:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:21:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:21:07 INFO - 'talos_options': ['--disable-e10s'], 02:21:07 INFO - 'tests': ['damp', 'tps']}, 02:21:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:21:07 INFO - 'tests': ['damp', 'tps']}, 02:21:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:21:07 INFO - 'tests': ['dromaeo_dom']}, 02:21:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:21:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:21:07 INFO - 'tests': ['basic_compositor_video']}, 02:21:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:21:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:21:07 INFO - 'tests': ['a11yr', 02:21:07 INFO - 'ts_paint', 02:21:07 INFO - 'tpaint', 02:21:07 INFO - 'sessionrestore', 02:21:07 INFO - 'sessionrestore_no_auto_restore', 02:21:07 INFO - 'tabpaint']}, 02:21:07 INFO - 'other-e10s': {'tests': ['a11yr', 02:21:07 INFO - 'ts_paint', 02:21:07 INFO - 'tpaint', 02:21:07 INFO - 'sessionrestore', 02:21:07 INFO - 'sessionrestore_no_auto_restore', 02:21:07 INFO - 'tabpaint']}, 02:21:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:21:07 INFO - 'ts_paint', 02:21:07 INFO - 'tpaint', 02:21:07 INFO - 'sessionrestore', 02:21:07 INFO - 'sessionrestore_no_auto_restore', 02:21:07 INFO - 'tabpaint']}, 02:21:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:21:07 INFO - 'ts_paint', 02:21:07 INFO - 'tpaint', 02:21:07 INFO - 'sessionrestore', 02:21:07 INFO - 'sessionrestore_no_auto_restore', 02:21:07 INFO - 'tabpaint']}, 02:21:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:21:07 INFO - 'tests': ['a11yr', 02:21:07 INFO - 'ts_paint', 02:21:07 INFO - 'tpaint', 02:21:07 INFO - 'sessionrestore', 02:21:07 INFO - 'sessionrestore_no_auto_restore', 02:21:07 INFO - 'tabpaint']}, 02:21:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:21:07 INFO - 'tests': ['a11yr', 02:21:07 INFO - 'ts_paint', 02:21:07 INFO - 'tpaint', 02:21:07 INFO - 'sessionrestore', 02:21:07 INFO - 'sessionrestore_no_auto_restore', 02:21:07 INFO - 'tabpaint']}, 02:21:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:21:07 INFO - 'tests': ['tsvgx', 02:21:07 INFO - 'tsvgr_opacity', 02:21:07 INFO - 'tart', 02:21:07 INFO - 'tscrollx', 02:21:07 INFO - 'cart']}, 02:21:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:21:07 INFO - 'tsvgr_opacity', 02:21:07 INFO - 'tart', 02:21:07 INFO - 'tscrollx', 02:21:07 INFO - 'cart']}, 02:21:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:21:07 INFO - 'talos_options': ['--disable-e10s'], 02:21:07 INFO - 'tests': ['tp5o']}, 02:21:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:21:07 INFO - 'tests': ['tp5o']}, 02:21:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:21:07 INFO - 'talos_options': ['--disable-e10s', 02:21:07 INFO - '--xperf_path', 02:21:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:21:07 INFO - 'tests': ['tp5n']}, 02:21:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:21:07 INFO - 'talos_options': ['--xperf_path', 02:21:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:21:07 INFO - 'tests': ['tp5n']}}, 02:21:07 INFO - 'talos.zip': {'path': '', 02:21:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:21:07 INFO - Running post-action listener: _resource_record_post_action 02:21:07 INFO - [mozharness: 2016-09-01 09:21:07.658036Z] Finished populate-webroot step (success) 02:21:07 INFO - [mozharness: 2016-09-01 09:21:07.658127Z] Running create-virtualenv step. 02:21:07 INFO - Running pre-action listener: _resource_record_pre_action 02:21:07 INFO - Running main action method: create_virtualenv 02:21:07 INFO - Creating virtualenv /builds/slave/test/build/venv 02:21:07 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 02:21:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:21:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:21:07 INFO - Using real prefix '/usr' 02:21:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:21:08 INFO - Installing distribute.............................................................................................................................................................................................done. 02:21:10 INFO - Installing pip.................done. 02:21:10 INFO - Return code: 0 02:21:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:21:10 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')]} 02:21:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:10 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')]} 02:21:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:10 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 0x7f728eb13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2265230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225f090>, '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 0x22629b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2262e40>, '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': 'db0483c52d987ecb441a263b000001ad-1472721272.115553-159134206', '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 02:21:10 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 02:21:10 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 02:21:10 INFO - Using env: {'DISPLAY': ':0', 02:21:10 INFO - 'HOME': '/home/cltbld', 02:21:10 INFO - 'LANG': 'en_US.UTF-8', 02:21:10 INFO - 'LANGUAGE': 'en_US:en', 02:21:10 INFO - 'LOGNAME': 'cltbld', 02:21:10 INFO - 'MAIL': '/var/mail/cltbld', 02:21:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:10 INFO - 'MOZ_NO_REMOTE': '1', 02:21:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:10 INFO - 'NO_EM_RESTART': '1', 02:21:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:10 INFO - 'PWD': '/builds/slave/test', 02:21:10 INFO - 'SHELL': '/bin/bash', 02:21:10 INFO - 'SHLVL': '1', 02:21:10 INFO - 'TERM': 'linux', 02:21:10 INFO - 'TMOUT': '86400', 02:21:10 INFO - 'USER': 'cltbld', 02:21:10 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472721272.115553-159134206', 02:21:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:10 INFO - '_': '/tools/buildbot/bin/python'} 02:21:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:10 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 02:21:10 INFO - Cleaning up... 02:21:10 INFO - Return code: 0 02:21:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:21:10 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')]} 02:21:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:10 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')]} 02:21:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:10 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 0x7f728eb13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2265230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225f090>, '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 0x22629b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2262e40>, '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': 'db0483c52d987ecb441a263b000001ad-1472721272.115553-159134206', '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 02:21:10 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 02:21:10 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 02:21:10 INFO - Using env: {'DISPLAY': ':0', 02:21:10 INFO - 'HOME': '/home/cltbld', 02:21:10 INFO - 'LANG': 'en_US.UTF-8', 02:21:10 INFO - 'LANGUAGE': 'en_US:en', 02:21:10 INFO - 'LOGNAME': 'cltbld', 02:21:10 INFO - 'MAIL': '/var/mail/cltbld', 02:21:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:10 INFO - 'MOZ_NO_REMOTE': '1', 02:21:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:10 INFO - 'NO_EM_RESTART': '1', 02:21:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:10 INFO - 'PWD': '/builds/slave/test', 02:21:10 INFO - 'SHELL': '/bin/bash', 02:21:10 INFO - 'SHLVL': '1', 02:21:10 INFO - 'TERM': 'linux', 02:21:10 INFO - 'TMOUT': '86400', 02:21:10 INFO - 'USER': 'cltbld', 02:21:10 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472721272.115553-159134206', 02:21:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:10 INFO - '_': '/tools/buildbot/bin/python'} 02:21:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:10 INFO - Downloading/unpacking psutil>=3.1.1 02:21:10 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 02:21:10 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 02:21:10 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 02:21:10 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 02:21:10 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 02:21:10 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 02:21:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:21:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:21:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:21:12 INFO - Installing collected packages: psutil 02:21:12 INFO - Running setup.py install for psutil 02:21:12 INFO - building 'psutil._psutil_linux' extension 02:21:12 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 02:21:12 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 02:21:12 INFO - building 'psutil._psutil_posix' extension 02:21:12 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 02:21:13 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:21:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:21:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:21:13 INFO - Successfully installed psutil 02:21:13 INFO - Cleaning up... 02:21:13 INFO - Return code: 0 02:21:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:21:13 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')]} 02:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:13 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')]} 02:21:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:13 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 0x7f728eb13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2265230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225f090>, '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 0x22629b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2262e40>, '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': 'db0483c52d987ecb441a263b000001ad-1472721272.115553-159134206', '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 02:21:13 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 02:21:13 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 02:21:13 INFO - Using env: {'DISPLAY': ':0', 02:21:13 INFO - 'HOME': '/home/cltbld', 02:21:13 INFO - 'LANG': 'en_US.UTF-8', 02:21:13 INFO - 'LANGUAGE': 'en_US:en', 02:21:13 INFO - 'LOGNAME': 'cltbld', 02:21:13 INFO - 'MAIL': '/var/mail/cltbld', 02:21:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:13 INFO - 'MOZ_NO_REMOTE': '1', 02:21:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:13 INFO - 'NO_EM_RESTART': '1', 02:21:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:13 INFO - 'PWD': '/builds/slave/test', 02:21:13 INFO - 'SHELL': '/bin/bash', 02:21:13 INFO - 'SHLVL': '1', 02:21:13 INFO - 'TERM': 'linux', 02:21:13 INFO - 'TMOUT': '86400', 02:21:13 INFO - 'USER': 'cltbld', 02:21:13 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472721272.115553-159134206', 02:21:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:13 INFO - '_': '/tools/buildbot/bin/python'} 02:21:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:21:13 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 02:21:13 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 02:21:13 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 02:21:13 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 02:21:13 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 02:21:13 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 02:21:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:21:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:21:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:21:15 INFO - Installing collected packages: mozsystemmonitor 02:21:15 INFO - Running setup.py install for mozsystemmonitor 02:21:15 INFO - Successfully installed mozsystemmonitor 02:21:15 INFO - Cleaning up... 02:21:15 INFO - Return code: 0 02:21:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:21: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')]} 02:21:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21: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')]} 02:21:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21: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', '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 0x7f728eb13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2265230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225f090>, '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 0x22629b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2262e40>, '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': 'db0483c52d987ecb441a263b000001ad-1472721272.115553-159134206', '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 02:21: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:21: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 jsonschema==2.5.1 02:21:15 INFO - Using env: {'DISPLAY': ':0', 02:21:15 INFO - 'HOME': '/home/cltbld', 02:21:15 INFO - 'LANG': 'en_US.UTF-8', 02:21:15 INFO - 'LANGUAGE': 'en_US:en', 02:21:15 INFO - 'LOGNAME': 'cltbld', 02:21:15 INFO - 'MAIL': '/var/mail/cltbld', 02:21:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:15 INFO - 'MOZ_NO_REMOTE': '1', 02:21:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:15 INFO - 'NO_EM_RESTART': '1', 02:21:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:15 INFO - 'PWD': '/builds/slave/test', 02:21:15 INFO - 'SHELL': '/bin/bash', 02:21:15 INFO - 'SHLVL': '1', 02:21:15 INFO - 'TERM': 'linux', 02:21:15 INFO - 'TMOUT': '86400', 02:21:15 INFO - 'USER': 'cltbld', 02:21:15 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472721272.115553-159134206', 02:21:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:15 INFO - '_': '/tools/buildbot/bin/python'} 02:21:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:15 INFO - Downloading/unpacking jsonschema==2.5.1 02:21: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 02:21: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 02:21: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 02:21: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 02:21: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 02:21: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 02:21:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:21:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:21: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 02:21: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 02:21: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 02:21: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 02:21: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 02:21: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 02:21:17 INFO - Downloading functools32-3.2.3-2.tar.gz 02:21:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:21:17 INFO - warning: no files found matching '*.txt' 02:21:17 INFO - no previously-included directories found matching 'build' 02:21:17 INFO - no previously-included directories found matching 'dist' 02:21:17 INFO - no previously-included directories found matching '.git*' 02:21:17 INFO - Installing collected packages: jsonschema, functools32 02:21:17 INFO - Running setup.py install for functools32 02:21:18 INFO - warning: no files found matching '*.txt' 02:21:18 INFO - no previously-included directories found matching 'build' 02:21:18 INFO - no previously-included directories found matching 'dist' 02:21:18 INFO - no previously-included directories found matching '.git*' 02:21:18 INFO - Successfully installed jsonschema functools32 02:21:18 INFO - Cleaning up... 02:21:18 INFO - Return code: 0 02:21:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:21:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f728eb13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2265230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225f090>, '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 0x22629b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2262e40>, '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': 'db0483c52d987ecb441a263b000001ad-1472721272.115553-159134206', '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 02:21:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:21:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:21:18 INFO - Using env: {'DISPLAY': ':0', 02:21:18 INFO - 'HOME': '/home/cltbld', 02:21:18 INFO - 'LANG': 'en_US.UTF-8', 02:21:18 INFO - 'LANGUAGE': 'en_US:en', 02:21:18 INFO - 'LOGNAME': 'cltbld', 02:21:18 INFO - 'MAIL': '/var/mail/cltbld', 02:21:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:18 INFO - 'MOZ_NO_REMOTE': '1', 02:21:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:18 INFO - 'NO_EM_RESTART': '1', 02:21:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:18 INFO - 'PWD': '/builds/slave/test', 02:21:18 INFO - 'SHELL': '/bin/bash', 02:21:18 INFO - 'SHLVL': '1', 02:21:18 INFO - 'TERM': 'linux', 02:21:18 INFO - 'TMOUT': '86400', 02:21:18 INFO - 'USER': 'cltbld', 02:21:18 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472721272.115553-159134206', 02:21:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:18 INFO - '_': '/tools/buildbot/bin/python'} 02:21:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:21:18 INFO - Cleaning up... 02:21:18 INFO - Return code: 0 02:21:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:21:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f728eb13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2265230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225f090>, '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 0x22629b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2262e40>, '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': 'db0483c52d987ecb441a263b000001ad-1472721272.115553-159134206', '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 02:21:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:21:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:21:18 INFO - Using env: {'DISPLAY': ':0', 02:21:18 INFO - 'HOME': '/home/cltbld', 02:21:18 INFO - 'LANG': 'en_US.UTF-8', 02:21:18 INFO - 'LANGUAGE': 'en_US:en', 02:21:18 INFO - 'LOGNAME': 'cltbld', 02:21:18 INFO - 'MAIL': '/var/mail/cltbld', 02:21:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:18 INFO - 'MOZ_NO_REMOTE': '1', 02:21:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:18 INFO - 'NO_EM_RESTART': '1', 02:21:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:18 INFO - 'PWD': '/builds/slave/test', 02:21:18 INFO - 'SHELL': '/bin/bash', 02:21:18 INFO - 'SHLVL': '1', 02:21:18 INFO - 'TERM': 'linux', 02:21:18 INFO - 'TMOUT': '86400', 02:21:18 INFO - 'USER': 'cltbld', 02:21:18 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472721272.115553-159134206', 02:21:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:18 INFO - '_': '/tools/buildbot/bin/python'} 02:21:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:18 INFO - Downloading/unpacking blobuploader==1.2.4 02:21:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:20 INFO - Downloading blobuploader-1.2.4.tar.gz 02:21:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:21:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:21: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 02:21: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 02:21: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 02:21: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 02:21: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 02:21: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 02:21:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:21:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:21: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 02:21: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 02:21: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 02:21: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 02:21: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 02:21: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 02:21:21 INFO - Downloading docopt-0.6.1.tar.gz 02:21:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:21:21 INFO - Installing collected packages: blobuploader, requests, docopt 02:21:21 INFO - Running setup.py install for blobuploader 02:21:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:21:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:21:21 INFO - Running setup.py install for requests 02:21:21 INFO - Running setup.py install for docopt 02:21:21 INFO - Successfully installed blobuploader requests docopt 02:21:21 INFO - Cleaning up... 02:21:21 INFO - Return code: 0 02:21:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:21:21 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')]} 02:21:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:21 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')]} 02:21:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:21 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 0x7f728eb13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2265230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225f090>, '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 0x22629b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2262e40>, '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': 'db0483c52d987ecb441a263b000001ad-1472721272.115553-159134206', '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 02:21:21 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 02:21:21 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 02:21:21 INFO - Using env: {'DISPLAY': ':0', 02:21:21 INFO - 'HOME': '/home/cltbld', 02:21:21 INFO - 'LANG': 'en_US.UTF-8', 02:21:21 INFO - 'LANGUAGE': 'en_US:en', 02:21:21 INFO - 'LOGNAME': 'cltbld', 02:21:21 INFO - 'MAIL': '/var/mail/cltbld', 02:21:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:21 INFO - 'MOZ_NO_REMOTE': '1', 02:21:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:21 INFO - 'NO_EM_RESTART': '1', 02:21:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:21 INFO - 'PWD': '/builds/slave/test', 02:21:21 INFO - 'SHELL': '/bin/bash', 02:21:21 INFO - 'SHLVL': '1', 02:21:21 INFO - 'TERM': 'linux', 02:21:21 INFO - 'TMOUT': '86400', 02:21:21 INFO - 'USER': 'cltbld', 02:21:21 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472721272.115553-159134206', 02:21:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:21 INFO - '_': '/tools/buildbot/bin/python'} 02:21:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:21:22 INFO - Running setup.py (path:/tmp/pip-7cksx3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:21:22 INFO - Running setup.py (path:/tmp/pip-R0zVjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:21:22 INFO - Running setup.py (path:/tmp/pip-4ozLjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:21:22 INFO - Running setup.py (path:/tmp/pip-xSGL6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:21:22 INFO - Running setup.py (path:/tmp/pip-ohu17t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:21:22 INFO - Running setup.py (path:/tmp/pip-zBTFB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:21:22 INFO - Running setup.py (path:/tmp/pip-9VvUF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:21:22 INFO - Running setup.py (path:/tmp/pip-iSbJVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:21:22 INFO - Running setup.py (path:/tmp/pip-njcucz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:21:22 INFO - Running setup.py (path:/tmp/pip-2pM98k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:21:22 INFO - Running setup.py (path:/tmp/pip-b1Hmnw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:21:22 INFO - Running setup.py (path:/tmp/pip-pNmb0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:21:22 INFO - Running setup.py (path:/tmp/pip-eenTtN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:21:22 INFO - Running setup.py (path:/tmp/pip-m7giyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:21:23 INFO - Running setup.py (path:/tmp/pip-f_vGCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:21:23 INFO - Running setup.py (path:/tmp/pip-UITyja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:21:23 INFO - Running setup.py (path:/tmp/pip-a0qWqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:21:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:21:23 INFO - Running setup.py install for manifestparser 02:21:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:21:23 INFO - Running setup.py install for mozcrash 02:21:23 INFO - Running setup.py install for mozdebug 02:21:23 INFO - Running setup.py install for mozdevice 02:21:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:21:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:21:23 INFO - Running setup.py install for mozfile 02:21:23 INFO - Running setup.py install for mozhttpd 02:21:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:21:23 INFO - Running setup.py install for mozinfo 02:21:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:21:23 INFO - Running setup.py install for mozInstall 02:21:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:21:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:21:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:21:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:21:24 INFO - Running setup.py install for mozleak 02:21:24 INFO - Running setup.py install for mozlog 02:21:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:21:24 INFO - Running setup.py install for moznetwork 02:21:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:21:24 INFO - Running setup.py install for mozprocess 02:21:24 INFO - Running setup.py install for mozprofile 02:21:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:21:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:21:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:21:24 INFO - Running setup.py install for mozrunner 02:21:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:21:24 INFO - Running setup.py install for mozscreenshot 02:21:24 INFO - Running setup.py install for moztest 02:21:24 INFO - Running setup.py install for mozversion 02:21:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:21:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:21:24 INFO - Cleaning up... 02:21:25 INFO - Return code: 0 02:21:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:21:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f728eb13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2265230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225f090>, '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 0x22629b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2262e40>, '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': 'db0483c52d987ecb441a263b000001ad-1472721272.115553-159134206', '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 02:21:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:21:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:21:25 INFO - Using env: {'DISPLAY': ':0', 02:21:25 INFO - 'HOME': '/home/cltbld', 02:21:25 INFO - 'LANG': 'en_US.UTF-8', 02:21:25 INFO - 'LANGUAGE': 'en_US:en', 02:21:25 INFO - 'LOGNAME': 'cltbld', 02:21:25 INFO - 'MAIL': '/var/mail/cltbld', 02:21:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:25 INFO - 'MOZ_NO_REMOTE': '1', 02:21:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:25 INFO - 'NO_EM_RESTART': '1', 02:21:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:25 INFO - 'PWD': '/builds/slave/test', 02:21:25 INFO - 'SHELL': '/bin/bash', 02:21:25 INFO - 'SHLVL': '1', 02:21:25 INFO - 'TERM': 'linux', 02:21:25 INFO - 'TMOUT': '86400', 02:21:25 INFO - 'USER': 'cltbld', 02:21:25 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472721272.115553-159134206', 02:21:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:25 INFO - '_': '/tools/buildbot/bin/python'} 02:21:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:21:25 INFO - Running setup.py (path:/tmp/pip-xZ_moz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:21:25 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)) 02:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:21:25 INFO - Running setup.py (path:/tmp/pip-cplbuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:21:25 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)) 02:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:21:25 INFO - Running setup.py (path:/tmp/pip-56BFdp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:21:25 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)) 02:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:21:25 INFO - Running setup.py (path:/tmp/pip-uYf31f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:21:25 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)) 02:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:21:25 INFO - Running setup.py (path:/tmp/pip-ONv4Oo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:21:25 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)) 02:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:21:25 INFO - Running setup.py (path:/tmp/pip-20bsid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:21:25 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)) 02:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:21:25 INFO - Running setup.py (path:/tmp/pip-Vjftdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:21:25 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)) 02:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:21:25 INFO - Running setup.py (path:/tmp/pip-kXC8rg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:21:25 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)) 02:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:21:25 INFO - Running setup.py (path:/tmp/pip-uAk2ke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:21:25 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)) 02:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:21:25 INFO - Running setup.py (path:/tmp/pip-ddhg41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:21:25 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)) 02:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:21:25 INFO - Running setup.py (path:/tmp/pip-k5bsUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:21:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:21:26 INFO - Running setup.py (path:/tmp/pip-vgAUjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:21:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:21:26 INFO - Running setup.py (path:/tmp/pip-82d1c9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:21:26 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)) 02:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:21:26 INFO - Running setup.py (path:/tmp/pip-xxZ70o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:21:26 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)) 02:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:21:26 INFO - Running setup.py (path:/tmp/pip-Glveix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:21:26 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)) 02:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:21:26 INFO - Running setup.py (path:/tmp/pip-jmLXD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:21:26 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)) 02:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:21:26 INFO - Running setup.py (path:/tmp/pip-8TxvKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:21:26 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)) 02:21:26 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)) 02:21:26 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)) 02:21:26 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)) 02:21:26 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)) 02:21:26 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)) 02:21:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:21:26 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 02:21:26 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 02:21:26 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 02:21:26 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 02:21:26 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 02:21:26 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 02:21:28 INFO - Downloading blessings-1.6.tar.gz 02:21:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:21:28 INFO - Installing collected packages: blessings 02:21:28 INFO - Running setup.py install for blessings 02:21:28 INFO - Successfully installed blessings 02:21:28 INFO - Cleaning up... 02:21:28 INFO - Return code: 0 02:21:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:21:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:21:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:21:28 INFO - Reading from file tmpfile_stdout 02:21:28 INFO - Current package versions: 02:21:28 INFO - argparse == 1.2.1 02:21:28 INFO - blessings == 1.6 02:21:28 INFO - blobuploader == 1.2.4 02:21:28 INFO - docopt == 0.6.1 02:21:28 INFO - functools32 == 3.2.3-2 02:21:28 INFO - jsonschema == 2.5.1 02:21:28 INFO - manifestparser == 1.1 02:21:28 INFO - mozInstall == 1.12 02:21:28 INFO - mozcrash == 0.17 02:21:28 INFO - mozdebug == 0.1 02:21:28 INFO - mozdevice == 0.48 02:21:28 INFO - mozfile == 1.2 02:21:28 INFO - mozhttpd == 0.7 02:21:28 INFO - mozinfo == 0.9 02:21:28 INFO - mozleak == 0.1 02:21:28 INFO - mozlog == 3.3 02:21:28 INFO - moznetwork == 0.27 02:21:28 INFO - mozprocess == 0.23 02:21:28 INFO - mozprofile == 0.28 02:21:28 INFO - mozrunner == 6.12 02:21:28 INFO - mozscreenshot == 0.1 02:21:28 INFO - mozsystemmonitor == 0.3 02:21:28 INFO - moztest == 0.7 02:21:28 INFO - mozversion == 1.4 02:21:28 INFO - psutil == 3.1.1 02:21:28 INFO - requests == 1.2.3 02:21:28 INFO - wsgiref == 0.1.2 02:21:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:28 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 0x7f728eb13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2265230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225f090>, '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 0x22629b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2262e40>, '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': 'db0483c52d987ecb441a263b000001ad-1472721272.115553-159134206', '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 02:21:28 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 02:21:28 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 02:21:28 INFO - Using env: {'DISPLAY': ':0', 02:21:28 INFO - 'HOME': '/home/cltbld', 02:21:28 INFO - 'LANG': 'en_US.UTF-8', 02:21:28 INFO - 'LANGUAGE': 'en_US:en', 02:21:28 INFO - 'LOGNAME': 'cltbld', 02:21:28 INFO - 'MAIL': '/var/mail/cltbld', 02:21:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:28 INFO - 'MOZ_NO_REMOTE': '1', 02:21:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:28 INFO - 'NO_EM_RESTART': '1', 02:21:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:28 INFO - 'PWD': '/builds/slave/test', 02:21:28 INFO - 'SHELL': '/bin/bash', 02:21:28 INFO - 'SHLVL': '1', 02:21:28 INFO - 'TERM': 'linux', 02:21:28 INFO - 'TMOUT': '86400', 02:21:28 INFO - 'USER': 'cltbld', 02:21:28 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472721272.115553-159134206', 02:21:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:28 INFO - '_': '/tools/buildbot/bin/python'} 02:21:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:21:29 INFO - Cleaning up... 02:21:29 INFO - Return code: 0 02:21:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:21:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f728eb13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2265230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225f090>, '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 0x22629b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2262e40>, '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': 'db0483c52d987ecb441a263b000001ad-1472721272.115553-159134206', '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 02:21:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:21:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:21:29 INFO - Using env: {'DISPLAY': ':0', 02:21:29 INFO - 'HOME': '/home/cltbld', 02:21:29 INFO - 'LANG': 'en_US.UTF-8', 02:21:29 INFO - 'LANGUAGE': 'en_US:en', 02:21:29 INFO - 'LOGNAME': 'cltbld', 02:21:29 INFO - 'MAIL': '/var/mail/cltbld', 02:21:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:29 INFO - 'MOZ_NO_REMOTE': '1', 02:21:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:29 INFO - 'NO_EM_RESTART': '1', 02:21:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:29 INFO - 'PWD': '/builds/slave/test', 02:21:29 INFO - 'SHELL': '/bin/bash', 02:21:29 INFO - 'SHLVL': '1', 02:21:29 INFO - 'TERM': 'linux', 02:21:29 INFO - 'TMOUT': '86400', 02:21:29 INFO - 'USER': 'cltbld', 02:21:29 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472721272.115553-159134206', 02:21:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:29 INFO - '_': '/tools/buildbot/bin/python'} 02:21:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:21:29 INFO - Cleaning up... 02:21:29 INFO - Return code: 0 02:21:29 INFO - Running post-action listener: _resource_record_post_action 02:21:29 INFO - Running post-action listener: _start_resource_monitoring 02:21:29 INFO - Starting resource monitoring. 02:21:29 INFO - [mozharness: 2016-09-01 09:21:29.298589Z] Finished create-virtualenv step (success) 02:21:29 INFO - [mozharness: 2016-09-01 09:21:29.299091Z] Running install step. 02:21:29 INFO - Running pre-action listener: _resource_record_pre_action 02:21:29 INFO - Running main action method: install 02:21:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:21:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:21:29 INFO - Reading from file tmpfile_stdout 02:21:29 INFO - Detecting whether we're running mozinstall >=1.0... 02:21:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:21:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:21:29 INFO - Reading from file tmpfile_stdout 02:21:29 INFO - Output received: 02:21:29 INFO - Usage: mozinstall [options] installer 02:21:29 INFO - Options: 02:21:29 INFO - -h, --help show this help message and exit 02:21:29 INFO - -d DEST, --destination=DEST 02:21:29 INFO - Directory to install application into. [default: 02:21:29 INFO - "/builds/slave/test"] 02:21:29 INFO - --app=APP Application being installed. [default: firefox] 02:21:29 INFO - mkdir: /builds/slave/test/build/application 02:21:29 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'] 02:21:29 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 02:21:45 INFO - Reading from file tmpfile_stdout 02:21:45 INFO - Output received: 02:21:45 INFO - /builds/slave/test/build/application/firefox/firefox 02:21:45 INFO - Running post-action listener: _resource_record_post_action 02:21:45 INFO - [mozharness: 2016-09-01 09:21:45.730516Z] Finished install step (success) 02:21:45 INFO - [mozharness: 2016-09-01 09:21:45.730798Z] Running run-tests step. 02:21:45 INFO - Running pre-action listener: _resource_record_pre_action 02:21:45 INFO - Running main action method: run_tests 02:21:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:21:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:21:45 INFO - Python 2.7.3 02:21:45 INFO - Return code: 0 02:21:45 INFO - grabbing minidump binary from tooltool 02:21:45 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')]} 02:21:45 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 0x225f090>, '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 0x22629b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2262e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:21:45 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 02:21:45 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 02:21:45 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 02:21:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:21:45 INFO - Return code: 0 02:21:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:21:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:21:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:21:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:21:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:21:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b2BCI4rkSmiO8hQL-mCKjA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 02:21:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/b2BCI4rkSmiO8hQL-mCKjA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --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 02:21:45 INFO - Using env: {'DISPLAY': ':0', 02:21:45 INFO - 'HOME': '/home/cltbld', 02:21:45 INFO - 'LANG': 'en_US.UTF-8', 02:21:45 INFO - 'LANGUAGE': 'en_US:en', 02:21:45 INFO - 'LOGNAME': 'cltbld', 02:21:45 INFO - 'MAIL': '/var/mail/cltbld', 02:21:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:21:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:21:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:45 INFO - 'MOZ_NO_REMOTE': '1', 02:21:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:21:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:45 INFO - 'NO_EM_RESTART': '1', 02:21:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:45 INFO - 'PWD': '/builds/slave/test', 02:21:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:21:45 INFO - 'SHELL': '/bin/bash', 02:21:45 INFO - 'SHLVL': '1', 02:21:45 INFO - 'TERM': 'linux', 02:21:45 INFO - 'TMOUT': '86400', 02:21:45 INFO - 'USER': 'cltbld', 02:21:45 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472721272.115553-159134206', 02:21:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:45 INFO - '_': '/tools/buildbot/bin/python'} 02:21:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b2BCI4rkSmiO8hQL-mCKjA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 02:21:46 INFO - mozversion application_buildid: 20160901012820 02:21:46 INFO - mozversion application_changeset: af5df7bd1d265bb95c76b69fa4fbcc60a84094f9 02:21:46 INFO - mozversion application_display_name: Nightly 02:21:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:21:46 INFO - mozversion application_name: Firefox 02:21:46 INFO - mozversion application_remotingname: firefox 02:21:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:21:46 INFO - mozversion application_vendor: Mozilla 02:21:46 INFO - mozversion application_version: 51.0a1 02:21:46 INFO - mozversion platform_buildid: 20160901012820 02:21:46 INFO - mozversion platform_changeset: af5df7bd1d265bb95c76b69fa4fbcc60a84094f9 02:21:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:21:46 INFO - mozversion platform_version: 51.0a1 02:21:46 INFO - using testdate: 1472721706 02:21:46 INFO - actual date: 1472721706 02:21:46 INFO - starting webserver on 'localhost:44583' 02:21:46 INFO - SUITE-START | Running 2 tests 02:21:46 INFO - TEST-START | dromaeo_css 02:21:46 INFO - operating with platform_type : linux_ 02:21:46 INFO - Initialising browser for dromaeo_css test... 02:21:46 INFO - TEST-INFO | started process 12181 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpikTVhd/profile http://localhost:44583/getInfo.html) 02:21:50 INFO - PROCESS | 12181 | __metrics Screen width/height:1600/1200 02:21:50 INFO - PROCESS | 12181 | colorDepth:24 02:21:50 INFO - PROCESS | 12181 | Browser inner width/height: 1024/697 02:21:50 INFO - PROCESS | 12181 | __metrics 02:21:51 INFO - PROCESS | 12181 | 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" 02:21:51 INFO - PROCESS | 12181 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:21:52 INFO - PROCESS | 12181 | console.error: PushService: 02:21:52 INFO - PROCESS | 12181 | stateChangeProcessEnqueue: Error transitioning state 02:21:52 INFO - PROCESS | 12181 | UnknownError 02:21:52 INFO - TEST-INFO | 12181: exit 0 02:21:52 INFO - Browser initialized. 02:21:52 INFO - Running cycle 1/1 for dromaeo_css test... 02:21:52 INFO - TEST-INFO | started process 12262 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpikTVhd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:22:05 INFO - PROCESS | 12262 | RSS: Main: 182411264 02:22:05 INFO - PROCESS | 12262 | 02:22:56 INFO - PROCESS | 12262 | 1472721776020 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] 02:25:09 INFO - PROCESS | 12262 | Cycle 1(1): loaded http://localhost:44583/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44583/tests/dromaeo/cssquery-ext.html) 02:25:10 INFO - PROCESS | 12262 | RSS: Main: 307281920 02:25:10 INFO - PROCESS | 12262 | 02:28:13 INFO - PROCESS | 12262 | Cycle 1(1): loaded http://localhost:44583/tests/dromaeo/cssquery-ext.html (next: http://localhost:44583/tests/dromaeo/cssquery-jquery.html) 02:28:14 INFO - PROCESS | 12262 | RSS: Main: 272326656 02:28:14 INFO - PROCESS | 12262 | 02:31:16 INFO - PROCESS | 12262 | Cycle 1(1): loaded http://localhost:44583/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44583/tests/dromaeo/cssquery-mootools.html) 02:31:17 INFO - PROCESS | 12262 | RSS: Main: 222117888 02:31:17 INFO - PROCESS | 12262 | 02:34:19 INFO - PROCESS | 12262 | Cycle 1(1): loaded http://localhost:44583/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44583/tests/dromaeo/cssquery-prototype.html) 02:34:20 INFO - PROCESS | 12262 | RSS: Main: 218939392 02:34:20 INFO - PROCESS | 12262 | 02:37:23 INFO - PROCESS | 12262 | Cycle 1(1): loaded http://localhost:44583/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44583/tests/dromaeo/cssquery-yui.html) 02:37:23 INFO - PROCESS | 12262 | RSS: Main: 223346688 02:37:23 INFO - PROCESS | 12262 | 02:40:27 INFO - PROCESS | 12262 | Cycle 1(1): loaded http://localhost:44583/tests/dromaeo/cssquery-yui.html (next: http://localhost:44583/tests/dromaeo/cssquery-dojo.html) 02:40:27 INFO - PROCESS | 12262 | RSS: Main: 310173696 02:40:27 INFO - PROCESS | 12262 | 02:40:27 INFO - PROCESS | 12262 | __start_tp_report 02:40:27 INFO - PROCESS | 12262 | _x_x_mozilla_page_load 02:40:27 INFO - PROCESS | 12262 | _x_x_mozilla_page_load_details 02:40:27 INFO - PROCESS | 12262 | |i|pagename|runs| 02:40:27 INFO - PROCESS | 12262 | |0;dojo.html;2571.138668546037;2575.0858445251924;2578.13632433135;2584.9483010339795;2597.3766296088934;4480.753558554278;4549.089734992425;4565.086982603484;4601.03378290559;4655.930161047583;4593.379893714347;4604.194266003445;4610.884727881805;4653.208954477738;4672.602828759559;4299.226139294926;4301.354796780477;4304.677149213806;4309.547497512763;4369.847055353063;4304.418903448026;4331.328644060176;4345.869623911288;4359.149965756678;4401.449818772653;4347.60871521563;4356.760378179199;4378.912421751563;4394.450693663292;4406.272964960794;4165.895852603679;4212.010177608259;4275.209086319041;4317.15815415994;4336.219480493525;4155.750654960712;4167.937480937789;4183.811728472226;4228.344606585953;4245.660347172219;4539.500654927955;4590.380298659672;4608.608268297199;4610.654200934943;4612.308153776927;4782.880427989293;4868.657397759195;4883;4888.657793954425;4955.653104282702;4872.220444728861;4919.385076865392;4940.678855874393;4945.307656928033;4949.430815456197;4574.451065872084;4586.633069354443;4593.920428699253;4601.723896566216;4605.677602567788;4866.853994380174;5029.094762942632;5034.546890779848;5050.242463630411;5063.949360506422;4867.58625516835;4868.659193856396;4884.658073934862;4941.950580494149;4946.851594452172;4988.052270068675;5005.874853128701;5006.249062640633;5007.12375334315;5069.721165335868;4718.079974404958;4759.214729569651;4938.38270216223;4947.035328110984;5010.949890501121;4808.735519546389;4833.275008748646;4844.2007068833955;4893.6329775266995;4912.778924948386;4114.650254728322;4121.052158003676;4125.876223713293;4130.091379896418;4173.353130264813;3628.455731640275;3660.762050466711;3676.8713095041544;3682.024263570156;3725.403935370382;4094.836206551764;4212.936805947913;4274.166537525215;4278.978605107017;4326.394304797331;4948.38145231846;4993.151164302078;4994.600431965434;4996.975015124901;5043.672161309577;4266.765327906995;4267.4025636410925;4267.530571637118;4268.59448352406;4322.3516472528745;4341.13177364522;4434.512203657595;4463.174312752151;4474.7762611869275;4534.274516077412;4658.953410465852;4675.76621168947;4680.789364478538;4731.7634118293945;4744.098621261949;4989.226669866177;5001.42483614389;5001.799928002839;5004.3994720633755;5057.949420505748;4488.618467430174;4640.141573808856;4673.6494762892235;4678.415198100238;4696.1546921554445;4920.827771027997;4921.557059864629;4922.532359425849;4922.704637721748;4976.651634385703;4993.875153121201;4996.3005179274205;5002.949970500248;5005.299258103942;5006.249062640633;4692.178868698033;4749.097671442415;4778.880527986828;4782.713037217778;4928.457869634266;4763.595094416874;4781.306710526885;4786.617070634411;4824.421069471686;4831.0820944020525;4667.579917807414;4672.953270467252;4673.532646735299;4721.669483136147;4758.547937945889;4685.742284174266;4736.668433209642;4801.4958429364415;4818.734969576707;4819.759012049313;4707.8587642370785;4732.881677958078;4739.1469535482565;4779.904401912012;4821.879453013703 02:40:27 INFO - PROCESS | 12262 | |1;ext.html;558.5057224356444;570.0337927213372;581.148617275691;590.8463799412151;593.0777640768606;27203.863980680093;38245.808770956144;39257.60742392579;39309.80345098278;43162.35256471155;39174.21651566974;39313.80343098288;39521.20957580847;39581.40627890584;39625.20749585007;7612.92387076129;7757.146713861499;7764.844703105934;7767.106782719975;7767.6116194190345;7522.9247707523045;7590.089189297264;7598.8480230395635;7599.240075992412;7613.162552119263;7616.771496855104;7638.3889288857035;7657.387409007294;7663;7667;7590.506617069873;7620.885686714703;7623.542587444771;7624.885626715603;7629.580373079479;7681.155072941972;7714.190010048977;7746.302832745024;7747.535147891144;7751.8449631007625;36769.63230367689;37037.44443833345;37043.814780925924;37077.44383834245;37088.25823483515;2764.5991331256855;2780.3605170810624;2807.05963502227;2868.942621147565;3087.706667866549;27539.31151721203;27820.860895695594;27876.581851272247;27970.580441293194;28133;3370.713489353408;3441.4149594568735;3485.2506711057245;3491.7555771096036;3538.7169026478077;269971;271162;272103;272147;272353;30411.391772164432;52562;53104;53126.20310695343;53188.73405632947;30588;32490.350192996008;32491.18772030671;32514;32535.837320813243;13213.801792973112;13437.86562134366;13447.19316840973;13449.260290684106;13452.058355915187;11043.171762117874;11247.325160490396;11267.267627604344;11269.38018408979;11279.266847654877;7526.736564220226;7590.620468976639;7652;7654.617269136521;7655.540667559964;2947.9705202948126;2999.9550006749914;3020.8489575521576;3023.289526961162;3035.5598438226334;795.745361484331;871.2376670413388;875.6278581602793;906.2523418180028;945.1068740040733;24435.87782061114;25810.612840807404;26159.346016349362;26472.60291095635;26572.202833915013;746.2984794293346;751.1849643137148;793.3970182661104;802.3741481644327;954.8090381923504;12725.236485810881;12878.45972307278;13074.215547067206;13116.147450415692;13201.141925774795;383530;388387;388451;390310;391837;47806.5219347809;48227;48262.51737482651;48364.758176208896;48438.75780621074;1060.1412855587;1153.233099988515;1178.8290697848936;1189.8869607387285;1193.0813273779142;25768.61347079758;27560.724392755816;28014;28317;28407.573886392132;37437.81281093577;37864;37956.24087518289;37997;38008.619913801616;281557;281659;282254;282515;283149;21509;23081.422964426023;24097.638535421633;24098.15656452016;24103.276901692978;37476;37834.81082594679;37934.62065379311;38219.617803822715;39407.80296098501;33586.664133358354;33758.49362259519;33982;34252.828735856165;34331.65668343285;32961;33537.329253415286;33617.83191084029;33713.831430842685;34068.829655851565;33370;33936.83031584826;34109;34225.14437139092;34576.30847383088;29838.254043648216;31088;31217.375652486367;31616.525752114198;31780.682193177774;23678.171264006367;23690.88154559216;24161;24311.51376972486;25015.87492062528 02:40:27 INFO - PROCESS | 12262 | |2;jquery.html;339.89123480486256;357.33000623830316;363.9981800091;365.3733846453332;388.3340071776902;12401.813972790404;15517.456889008887;15895.761563576541;17555.122243887818;17672;16643.33426662935;16902.239399227034;16921.238544265507;17011.744823827623;17097.40159094432;5036.874078148048;5052.964142350827;5143.794248230085;5176.689398636075;5188.558972487343;3732.328180927432;3934.7245692801516;5107.719075450848;5208.973955130238;5209.609279304067;3942.7634341939433;3955.0507878109333;5616.494515493605;5986.970065149668;5989.3112292086535;5861.472467477947;6042.395760423967;6063.6361818290825;6071.241094863142;6072.574919755619;5347.171188465794;5347.812826551091;5353.652012619167;5366.490183432567;5369.060414427459;20028.899855500775;20519.076641551164;20519.692204616942;20742;20745;1926.1332400419867;1952.326447375653;2127.638301488735;2343.121329501437;2519.344970307715;12695.873041269562;13199.604011879659;13256.3371831409;13376.352625831392;13820.93089534556;1596.5370042687607;1632.5673696470444;1637.2795969773263;1638.7623794549843;1685.3427163406282;69011.65494172498;69091;70700;73289.63355183243;73675;8408.32733381328;8948.5078320693;9070.092990700878;9464.242860571137;9583.808323833624;11849.34828584419;11917.523299068114;11955.581554645545;11966.700832479257;11989.460474278678;5636.887262254732;5690.2033715279895;5753.510951569164;6066.696665166724;7135.6432178391915;6807.319268073252;6811.2167100784045;6839.62382068991;7055.788326350115;7068.787936361918;3695.1870588470492;3738.36447803874;3749.4375843623675;3832.463455116286;3846.7307288489537;1787.0156838080436;1836.9448916532526;1840.484664294;1858.4053103006909;1863.1708889544022;807.9232472915064;809.0816922792673;830.2693629605908;845.995770021146;882.9757481321636;16019.599510012344;17415.825841741673;17489.65020699579;17600.64798704019;17873.195706192993;801.867691830853;808.3573559020592;816.5141740664295;852.518327145161;856.6958729651009;8393.328533717287;8808.427452215585;9546.140847323773;9675.564599593035;9693.563789629483;373620;374695;375068;377874;382101;77162;79116.20883791204;79219;79717;79787;854.7393045121298;871.1201686296886;873.0658195730507;875.2560323724911;881.352206128495;14853.777193342325;14920.792029713664;15012.24938753036;15036;15576.92211538935;25265.49469010646;26090.086846961025;35509.28981420409;37955.48178072957;39264.46619804231;50307.74846125746;50954.74522627512;51385.7430712859;51571.484285156665;52534;4892.730899800403;6712.563683360566;7516.624168791429;7806.219378062148;7948.562829044458;9525.333226674065;10543.31468454548;11016.339019658846;11418.200725949437;12005.579804706793;10039;10067.446290454096;10355.689329320132;10465.68602941913;10603.522841471999;10035.749106272402;10094.24293178;10164.644237451654;10209.030142136486;10251.487425628839;10122.139618132247;10139.188864890644;10263.58945642166;10371.170306375623;10426.791464170827;6960.721571137098;7056.329648683367;7159.427245820218;7220.927790722026;7225.313595208447;8280.378971577276;10010.59957601717;10098.596056157672;10455.477226138815;10584.417857017937 02:40:27 INFO - PROCESS | 12262 | |3;mootools.html;1226.1662069792537;1341.4902337111896;1361.9659508512286;1417.603071140081;1662.3267576631467;7268.890966635505;7668.118166410864;7717.575533345664;7885.9211407885905;7892.289693927545;7682.270184332493;7758.612069396536;7772.6113694315345;7783.961080194591;7800.7269745558915;1850.7594012778388;2059.639563076463;2194.3855720398315;2226.7216597925258;2227.354067320475;2140.5825863956534;2174.652055671093;2180.923667671632;2184.355615093551;2190.4742861713235;2175.042981088324;2196.593630178414;2201.9119235230573;2222.344408399526;2225.310153852303;2045.70337301092;2079.1579410338836;2089.2374283386453;2097.685347197917;2137.2519618133683;2162.967555486669;2173.8913054347217;2175.6627722702847;2175.760666326703;2183.5087105401317;7617.085949686073;7647.541147531166;7654.732084377076;7657.387409007321;7659.7319093832;4330.2638551446325;4437.977810110961;4441.178381999341;4451.799669014902;4454.554544545552;2834.702356252605;2865.068852622906;3003.3242520432946;3017.607710997578;3022.22933152047;970.2141265574836;985.2856678907806;996.2528103922059;1006.6124542051363;1011.5245834457793;10255.846162307571;10480.68557943263;10486.318389304672;10494.265401421904;10515.894841051568;4119.0937993641355;4147.108371700099;4306.375575541529;4311.116221174651;4338.696291259582;8538.786530336667;8543.316534677335;8547;8551.871721924175;8554.529500877512;4604.056168485453;4604.953950460453;4605.769711514478;4606.424196975378;4613.515580864028;3335.6164041135094;4033.8184781684895;4119.9176016480105;4126.463559737215;4133.2146892091005;3608.80151591665;3614.1868079682386;3723.2181241938956;3740.6259374062374;3744.4383342498845;1168.9941550292365;1172.0974849365941;1174.0431548288118;1175.2419689300352;1178.9823152652716;619.5260625621403;631.5452873930763;655.4199533412964;721.3147509865648;734.8420089680744;4789.233722604366;4969.428515720666;5090.211017292326;5271.920921186185;5311.601629877775;730.7625021867914;756.8864670299389;846.3356265331685;885.3536918049859;970.257752819094;3640.10817349751;3820.9617903821163;3888.922221555553;3937.1731936293127;3965.4844870166694;9504.287178461644;9529.380590261611;9636.566354514063;9652.75868103303;9689;8882.822343553222;9483.762905927408;9561.235101191887;9569.952150239204;9577.23382129442;6999.615021173782;7328.59692716895;7336.889946650805;7344.30229128232;7351.3751331137455;5079.44126146131;5241.659292146151;5250.26496290512;5351.5451186648015;5501.064818980863;8504.617292221741;8637.827243455222;8752.299816014576;8920.330975177018;8969.730908072768;8782.473051616924;8994.100589940954;9056.27549796028;9070.727878163665;9089.272858171198;5723.7996670116345;5959.40405959418;5961.314448838439;6342.619442833445;6425.325340839145;6603.867922641424;6687.1975362956755;6791.66041697923;6820.35206655367;6926.168859736864;6273.811785646438;6372.617642941438;6412.6793660317735;6526.347365263436;6529.640869752209;5935.673537955454;5976.731047102804;6051.818445446644;6058.151858739868;6065;6012.939870601238;6136.662483563447;6145.508359331332;6145.84635384119;6146.754129834757;4376.9124617508105;4477.70894891831;4479;4551.135284295973;4628.814847406066;4304.268274393423;4321.891952701208;4359.433273674402;4370.825166993284;4470.307102399133 02:40:27 INFO - PROCESS | 12262 | |4;prototype.html;273.08652557196183;283.2663401789365;283.9843808590527;297.6844544782531;303.65686773945436;4674.4624368197665;4746.454157771857;4751.382320298365;4755.167845627015;4776.2297867237;4610.294191149271;4651.162790697673;4682.321063445798;4685.2269375553;4737.43150821901;3483.581970163578;3568.2149927016017;3695.1870588470492;3704.7033538261526;3719.293334266494;3689.114612492996;3717.237966216919;3734.1038150843738;3735.8879233622897;3741.877436768972;3637.4725664778593;3638.4349033931016;3644.2529281497227;3689.8155092245415;3693.926121477569;3469.3755124077657;3562.4656301554846;3635.800030998294;3668.9633103669157;3703.4444833275224;3250.8699652013893;3271.1331497153274;3274.6889045540634;3279.1310302769784;3304;4539.773011349453;4551.226291530448;4556.179887620227;4569.405977222973;4622.8150873965005;3959.4852669152824;4223.176480586287;4231.196072746168;4232.682548808852;4234.242789242491;4862.927056094161;4885.413750349981;4886.926696099561;4905.994271174401;4923.144576145827;3616.367135751233;3622.605296960689;3622.800745958971;3623.148560088377;3632.929230338708;4932.260160975882;5124.923126153073;5153.587712982952;5169.327987361657;5197.870053248661;3615.3311637347174;3631.1466805300734;3655.61616030313;3665.5337864854273;3668.5414323209598;3750.962490375116;3755.6807671347697;3759.793211373401;3760.7555508891833;3765.1904840459433;4216.325387937915;4219.78901054946;4230.344296633965;4230.767307798101;4232.153569286093;4770.403699537558;4863.8540843774745;4892.119418504632;4963.950360496421;4978.850634480971;1270.7585558743808;1276.6489215465822;1277.9329260067761;1287.2598256002836;1299.7205600795874;784.7724159993538;807.6930766308765;814.3932770086324;821.1131977464324;833.5662660224405;4148.639601922452;4285.400043993844;4285.807138678767;4288.185244803477;4302.22559939214;4969.478204788517;4976.850694479172;4982.427020892571;4983.6760610560195;5014.247862820606;4290.15523324967;4295.312749959991;4307.612314891675;4307.784610769449;4310.599055307038;2502.349389158832;2627.316897606636;2632.7104018557943;2634.76287134155;2637.5384307746067;4675.742834144155;4692.976535117303;4703.717776933395;4717.292406139107;4719.858404247878;5093.23601459784;5110.540051395392;5127.820526281562;5128.9230661540105;5129.7178655173575;4469.664775141878;4733.337332773414;4738.218193998021;4769.594584460221;4772.498887616889;5066;5067.429096979948;5072.315237442898;5074.923876141935;5085.745712714275;4797.313504437526;4947.628927830355;4955.207166853286;4974.626902982219;4987.775550100182;4751.738654374042;4776.952230477651;4779.211430114131;4779.665423420327;4782.497837727128;3621.4567814827988;3625.1480901987484;3629.147150419702;3635.8727444539313;3638.308721342936;5030.57240134578;5049.636598118561;5051.520105589963;5061.190209566452;5068.569171620454;4787.593054590398;4878.804847806048;4899.6570240084275;4906.282801019614;4930.6795058321095;4925;4931.235658472942;4939.604831613534;4940.160172770566;4940.481249468898;4856.1987272099705;4860.416749990024;4862.173430516891;4865.416150062015;4867.367242258484;4663.743494107856;4905.828296009765;4919.926201106915;4935.777889994887;4936.148944145945;4825.324454576432;4832.371791667061;4834.187179807572;4840.29815676732;4844.128056949642 02:40:27 INFO - PROCESS | 12262 | |5;yui.html;589.8171566814287;643.9710213040413;653.2063542795509;664.2294937872069;665.4908994619117;11989.820152697706;12153.878461215396;12177;12320.691982700437;12902.161359511638;12907.096503244753;13056.477740890354;13076.150050246728;13077.67305817355;13087.541936032241;605.7213681706398;731.5939653492323;746.5781833264216;746.6640011994624;746.7498388039986;729.5403895545799;761.8323968726899;766.0118447203101;767.5548182054395;768.5465575310566;792.053496072194;794.3962588432804;794.7854079398559;794.8370584030259;794.9562774047425;630.1839118341712;789.7907054630527;789.893364395805;789.9999999999972;790.0479921694345;564.1932037186821;580.6371018113679;581.584167320368;583.3816154875846;583.7781642975684;11341.26281791681;11344.886551134465;11360.715982100432;11407.54369825206;11432.485538150802;12058.517659293619;12358.134930554865;12469.251844889335;12705.237685738794;12707.745845083047;11713.824292635618;11772.70568235801;12075.57735479254;12188.81716774249;12433;4132.483439570054;4136.9793151034355;4198.475190601175;4301.505326887385;4354.129174165148;62726;63530.68234658843;64302;64465.03302450514;64580;9777.31558790892;9975.401475911323;10236.232282578836;10409.635662751767;10560.47197640115;16341.673166536602;16522.75215871763;16527.256273467723;16532.256048477848;16533.256003479873;6275.1842260506755;6305.3379395163765;6415;6466.967665161644;6537.34626537352;3482.59950105736;3573.3746594345885;3598.568171819346;3620.728445366608;3657.707383409374;2557.360659835041;2617.7120516743144;2642;2642.2997905555044;2654.018013335078;475.58148829030233;476.92130798418566;521.1869483605587;532.4010488200774;554.5341912793273;479.64745911754835;481.65320968902336;572.9885402291931;573.2032474859948;583.5331734612294;7477.476576639692;7970.402219833536;8173.264406203471;8402.285805706584;8430.367722420842;479.85364463838164;508.6439492355292;545.9672419654834;555.9138333558305;573.761888816145;3850.114473671071;3953.723239373216;3968.9603103969166;3975.8012099394914;4028.516578010599;54680.45319546833;84759;98333;98444.50777746065;104712;68133;85621.57189214014;88408.5579572098;89779.55110224408;90205.09794901968;49307.75346123247;63346.68326658337;63799;71865.64067179631;72889;7157.821054473679;8128.918710812816;8252.917470825216;8256.298214651822;8324.70863519774;35236.47145292771;40353.39469908013;42833;43859.561404385546;45562.54437455583;55897.1219835074;63304;65053.349466504726;65356.673216633615;66258.66870665616;10027.799444010932;10381.273310868166;10617.203709721647;11088.279261847954;11407.714807129889;11798.351090690094;11817.645470635895;11907.285562866256;12208.084393670688;12225.08311876595;10206.744831379276;10237.897621023694;10409.219308551737;10555.94722026385;10750.892491075301;11533.480993355486;12284.447199876206;12297.877021229673;12324.568640097554;12341.136120471481;9649.517524123907;9659.372140810825;10215.846762298721;10240.129588985019;10245.231607629308;9966.750831228986;10143.847842282225;10374.740631484274;10599.804222629728;10729.088027517748;9310.581023853807;9810.705678829647;10180.185585153318;10185.08334249921;10206.285560010729 02:40:27 INFO - PROCESS | 12262 | __end_tp_report 02:40:27 INFO - PROCESS | 12262 | __start_cc_report 02:40:27 INFO - PROCESS | 12262 | _x_x_mozilla_cycle_collect,1163 02:40:27 INFO - PROCESS | 12262 | __end_cc_report 02:40:27 INFO - PROCESS | 12262 | __startTimestamp1472722827253__endTimestamp 02:40:27 INFO - PROCESS | 12262 | 02:40:27 INFO - PROCESS | 12262 | ------- Summary: start ------- 02:40:27 INFO - PROCESS | 12262 | Number of tests: 6 02:40:27 INFO - PROCESS | 12262 | 02:40:27 INFO - PROCESS | 12262 | [#0] dojo.html Cycles:165 Average:4569.16 Median:4675.77 stddev:475.64 (10.2%) stddev-sans-first:450.54 02:40:27 INFO - PROCESS | 12262 | Values: 2571.1 2575.1 2578.1 2584.9 2597.4 4480.8 4549.1 4565.1 4601.0 4655.9 4593.4 4604.2 4610.9 4653.2 4672.6 4299.2 4301.4 4304.7 4309.5 4369.8 4304.4 4331.3 4345.9 4359.1 4401.4 4347.6 4356.8 4378.9 4394.5 4406.3 4165.9 4212.0 4275.2 4317.2 4336.2 4155.8 4167.9 4183.8 4228.3 4245.7 4539.5 4590.4 4608.6 4610.7 4612.3 4782.9 4868.7 4883.0 4888.7 4955.7 4872.2 4919.4 4940.7 4945.3 4949.4 4574.5 4586.6 4593.9 4601.7 4605.7 4866.9 5029.1 5034.5 5050.2 5063.9 4867.6 4868.7 4884.7 4942.0 4946.9 4988.1 5005.9 5006.2 5007.1 5069.7 4718.1 4759.2 4938.4 4947.0 5010.9 4808.7 4833.3 4844.2 4893.6 4912.8 4114.7 4121.1 4125.9 4130.1 4173.4 3628.5 3660.8 3676.9 3682.0 3725.4 4094.8 4212.9 4274.2 4279.0 4326.4 4948.4 4993.2 4994.6 4997.0 5043.7 4266.8 4267.4 4267.5 4268.6 4322.4 4341.1 4434.5 4463.2 4474.8 4534.3 4659.0 4675.8 4680.8 4731.8 4744.1 4989.2 5001.4 5001.8 5004.4 5057.9 4488.6 4640.1 4673.6 4678.4 4696.2 4920.8 4921.6 4922.5 4922.7 4976.7 4993.9 4996.3 5002.9 5005.3 5006.2 4692.2 4749.1 4778.9 4782.7 4928.5 4763.6 4781.3 4786.6 4824.4 4831.1 4667.6 4673.0 4673.5 4721.7 4758.5 4685.7 4736.7 4801.5 4818.7 4819.8 4707.9 4732.9 4739.1 4779.9 4821.9 02:40:27 INFO - PROCESS | 12262 | 02:40:27 INFO - PROCESS | 12262 | [#1] ext.html Cycles:180 Average:44970.79 Median:34292.24 stddev:84094.77 (245.2%) stddev-sans-first:84264.57 02:40:27 INFO - PROCESS | 12262 | Values: 558.5 570.0 581.1 590.8 593.1 27203.9 38245.8 39257.6 39309.8 43162.4 39174.2 39313.8 39521.2 39581.4 39625.2 7612.9 7757.1 7764.8 7767.1 7767.6 7522.9 7590.1 7598.8 7599.2 7613.2 7616.8 7638.4 7657.4 7663.0 7667.0 7590.5 7620.9 7623.5 7624.9 7629.6 7681.2 7714.2 7746.3 7747.5 7751.8 36769.6 37037.4 37043.8 37077.4 37088.3 2764.6 2780.4 2807.1 2868.9 3087.7 27539.3 27820.9 27876.6 27970.6 28133.0 3370.7 3441.4 3485.3 3491.8 3538.7 269971.0 271162.0 272103.0 272147.0 272353.0 30411.4 52562.0 53104.0 53126.2 53188.7 30588.0 32490.4 32491.2 32514.0 32535.8 13213.8 13437.9 13447.2 13449.3 13452.1 11043.2 11247.3 11267.3 11269.4 11279.3 7526.7 7590.6 7652.0 7654.6 7655.5 2948.0 3000.0 3020.8 3023.3 3035.6 795.7 871.2 875.6 906.3 945.1 24435.9 25810.6 26159.3 26472.6 26572.2 746.3 751.2 793.4 802.4 954.8 12725.2 12878.5 13074.2 13116.1 13201.1 383530.0 388387.0 388451.0 390310.0 391837.0 47806.5 48227.0 48262.5 48364.8 48438.8 1060.1 1153.2 1178.8 1189.9 1193.1 25768.6 27560.7 28014.0 28317.0 28407.6 37437.8 37864.0 37956.2 37997.0 38008.6 281557.0 281659.0 282254.0 282515.0 283149.0 21509.0 23081.4 24097.6 24098.2 24103.3 37476.0 37834.8 37934.6 38219.6 39407.8 33586.7 33758.5 33982.0 34252.8 34331.7 32961.0 33537.3 33617.8 33713.8 34068.8 33370.0 33936.8 34109.0 34225.1 34576.3 29838.3 31088.0 31217.4 31616.5 31780.7 23678.2 23690.9 24161.0 24311.5 25015.9 02:40:27 INFO - PROCESS | 12262 | 02:40:27 INFO - PROCESS | 12262 | [#2] jquery.html Cycles:180 Average:23812.43 Median:3839.60 stddev:62399.82 (1625.2%) stddev-sans-first:62549.98 02:40:27 INFO - PROCESS | 12262 | Values: 339.9 357.3 364.0 365.4 388.3 12401.8 15517.5 15895.8 17555.1 17672.0 16643.3 16902.2 16921.2 17011.7 17097.4 5036.9 5053.0 5143.8 5176.7 5188.6 3732.3 3934.7 5107.7 5209.0 5209.6 3942.8 3955.1 5616.5 5987.0 5989.3 5861.5 6042.4 6063.6 6071.2 6072.6 5347.2 5347.8 5353.7 5366.5 5369.1 20028.9 20519.1 20519.7 20742.0 20745.0 1926.1 1952.3 2127.6 2343.1 2519.3 12695.9 13199.6 13256.3 13376.4 13820.9 1596.5 1632.6 1637.3 1638.8 1685.3 69011.7 69091.0 70700.0 73289.6 73675.0 8408.3 8948.5 9070.1 9464.2 9583.8 11849.3 11917.5 11955.6 11966.7 11989.5 5636.9 5690.2 5753.5 6066.7 7135.6 6807.3 6811.2 6839.6 7055.8 7068.8 3695.2 3738.4 3749.4 3832.5 3846.7 1787.0 1836.9 1840.5 1858.4 1863.2 807.9 809.1 830.3 846.0 883.0 16019.6 17415.8 17489.7 17600.6 17873.2 801.9 808.4 816.5 852.5 856.7 8393.3 8808.4 9546.1 9675.6 9693.6 373620.0 374695.0 375068.0 377874.0 382101.0 77162.0 79116.2 79219.0 79717.0 79787.0 854.7 871.1 873.1 875.3 881.4 14853.8 14920.8 15012.2 15036.0 15576.9 25265.5 26090.1 35509.3 37955.5 39264.5 50307.7 50954.7 51385.7 51571.5 52534.0 4892.7 6712.6 7516.6 7806.2 7948.6 9525.3 10543.3 11016.3 11418.2 12005.6 10039.0 10067.4 10355.7 10465.7 10603.5 10035.7 10094.2 10164.6 10209.0 10251.5 10122.1 10139.2 10263.6 10371.2 10426.8 6960.7 7056.3 7159.4 7220.9 7225.3 8280.4 10010.6 10098.6 10455.5 10584.4 02:40:27 INFO - PROCESS | 12262 | 02:40:27 INFO - PROCESS | 12262 | [#3] mootools.html Cycles:180 Average:5008.95 Median:5165.94 stddev:2794.69 (54.1%) stddev-sans-first:2788.07 02:40:27 INFO - PROCESS | 12262 | Values: 1226.2 1341.5 1362.0 1417.6 1662.3 7268.9 7668.1 7717.6 7885.9 7892.3 7682.3 7758.6 7772.6 7784.0 7800.7 1850.8 2059.6 2194.4 2226.7 2227.4 2140.6 2174.7 2180.9 2184.4 2190.5 2175.0 2196.6 2201.9 2222.3 2225.3 2045.7 2079.2 2089.2 2097.7 2137.3 2163.0 2173.9 2175.7 2175.8 2183.5 7617.1 7647.5 7654.7 7657.4 7659.7 4330.3 4438.0 4441.2 4451.8 4454.6 2834.7 2865.1 3003.3 3017.6 3022.2 970.2 985.3 996.3 1006.6 1011.5 10255.8 10480.7 10486.3 10494.3 10515.9 4119.1 4147.1 4306.4 4311.1 4338.7 8538.8 8543.3 8547.0 8551.9 8554.5 4604.1 4605.0 4605.8 4606.4 4613.5 3335.6 4033.8 4119.9 4126.5 4133.2 3608.8 3614.2 3723.2 3740.6 3744.4 1169.0 1172.1 1174.0 1175.2 1179.0 619.5 631.5 655.4 721.3 734.8 4789.2 4969.4 5090.2 5271.9 5311.6 730.8 756.9 846.3 885.4 970.3 3640.1 3821.0 3888.9 3937.2 3965.5 9504.3 9529.4 9636.6 9652.8 9689.0 8882.8 9483.8 9561.2 9570.0 9577.2 6999.6 7328.6 7336.9 7344.3 7351.4 5079.4 5241.7 5250.3 5351.5 5501.1 8504.6 8637.8 8752.3 8920.3 8969.7 8782.5 8994.1 9056.3 9070.7 9089.3 5723.8 5959.4 5961.3 6342.6 6425.3 6603.9 6687.2 6791.7 6820.4 6926.2 6273.8 6372.6 6412.7 6526.3 6529.6 5935.7 5976.7 6051.8 6058.2 6065.0 6012.9 6136.7 6145.5 6145.8 6146.8 4376.9 4477.7 4479.0 4551.1 4628.8 4304.3 4321.9 4359.4 4370.8 4470.3 02:40:27 INFO - PROCESS | 12262 | 02:40:27 INFO - PROCESS | 12262 | [#4] prototype.html Cycles:180 Average:4086.73 Median:4679.03 stddev:1178.61 (25.2%) stddev-sans-first:1146.63 02:40:27 INFO - PROCESS | 12262 | Values: 273.1 283.3 284.0 297.7 303.7 4674.5 4746.5 4751.4 4755.2 4776.2 4610.3 4651.2 4682.3 4685.2 4737.4 3483.6 3568.2 3695.2 3704.7 3719.3 3689.1 3717.2 3734.1 3735.9 3741.9 3637.5 3638.4 3644.3 3689.8 3693.9 3469.4 3562.5 3635.8 3669.0 3703.4 3250.9 3271.1 3274.7 3279.1 3304.0 4539.8 4551.2 4556.2 4569.4 4622.8 3959.5 4223.2 4231.2 4232.7 4234.2 4862.9 4885.4 4886.9 4906.0 4923.1 3616.4 3622.6 3622.8 3623.1 3632.9 4932.3 5124.9 5153.6 5169.3 5197.9 3615.3 3631.1 3655.6 3665.5 3668.5 3751.0 3755.7 3759.8 3760.8 3765.2 4216.3 4219.8 4230.3 4230.8 4232.2 4770.4 4863.9 4892.1 4964.0 4978.9 1270.8 1276.6 1277.9 1287.3 1299.7 784.8 807.7 814.4 821.1 833.6 4148.6 4285.4 4285.8 4288.2 4302.2 4969.5 4976.9 4982.4 4983.7 5014.2 4290.2 4295.3 4307.6 4307.8 4310.6 2502.3 2627.3 2632.7 2634.8 2637.5 4675.7 4693.0 4703.7 4717.3 4719.9 5093.2 5110.5 5127.8 5128.9 5129.7 4469.7 4733.3 4738.2 4769.6 4772.5 5066.0 5067.4 5072.3 5074.9 5085.7 4797.3 4947.6 4955.2 4974.6 4987.8 4751.7 4777.0 4779.2 4779.7 4782.5 3621.5 3625.1 3629.1 3635.9 3638.3 5030.6 5049.6 5051.5 5061.2 5068.6 4787.6 4878.8 4899.7 4906.3 4930.7 4925.0 4931.2 4939.6 4940.2 4940.5 4856.2 4860.4 4862.2 4865.4 4867.4 4663.7 4905.8 4919.9 4935.8 4936.1 4825.3 4832.4 4834.2 4840.3 4844.1 02:40:27 INFO - PROCESS | 12262 | 02:40:27 INFO - PROCESS | 12262 | [#5] yui.html Cycles:180 Average:16993.08 Median:478.28 stddev:24282.89 (5077.1%) stddev-sans-first:24319.78 02:40:27 INFO - PROCESS | 12262 | Values: 589.8 644.0 653.2 664.2 665.5 11989.8 12153.9 12177.0 12320.7 12902.2 12907.1 13056.5 13076.2 13077.7 13087.5 605.7 731.6 746.6 746.7 746.7 729.5 761.8 766.0 767.6 768.5 792.1 794.4 794.8 794.8 795.0 630.2 789.8 789.9 790.0 790.0 564.2 580.6 581.6 583.4 583.8 11341.3 11344.9 11360.7 11407.5 11432.5 12058.5 12358.1 12469.3 12705.2 12707.7 11713.8 11772.7 12075.6 12188.8 12433.0 4132.5 4137.0 4198.5 4301.5 4354.1 62726.0 63530.7 64302.0 64465.0 64580.0 9777.3 9975.4 10236.2 10409.6 10560.5 16341.7 16522.8 16527.3 16532.3 16533.3 6275.2 6305.3 6415.0 6467.0 6537.3 3482.6 3573.4 3598.6 3620.7 3657.7 2557.4 2617.7 2642.0 2642.3 2654.0 475.6 476.9 521.2 532.4 554.5 479.6 481.7 573.0 573.2 583.5 7477.5 7970.4 8173.3 8402.3 8430.4 479.9 508.6 546.0 555.9 573.8 3850.1 3953.7 3969.0 3975.8 4028.5 54680.5 84759.0 98333.0 98444.5 104712.0 68133.0 85621.6 88408.6 89779.6 90205.1 49307.8 63346.7 63799.0 71865.6 72889.0 7157.8 8128.9 8252.9 8256.3 8324.7 35236.5 40353.4 42833.0 43859.6 45562.5 55897.1 63304.0 65053.3 65356.7 66258.7 10027.8 10381.3 10617.2 11088.3 11407.7 11798.4 11817.6 11907.3 12208.1 12225.1 10206.7 10237.9 10409.2 10555.9 10750.9 11533.5 12284.4 12297.9 12324.6 12341.1 9649.5 9659.4 10215.8 10240.1 10245.2 9966.8 10143.8 10374.7 10599.8 10729.1 9310.6 9810.7 10180.2 10185.1 10206.3 02:40:27 INFO - PROCESS | 12262 | -------- Summary: end -------- 02:40:27 INFO - PROCESS | 12262 | 02:40:28 INFO - TEST-INFO | 12262: exit 0 02:40:28 INFO - TEST-OK | dromaeo_css | took 1122201ms 02:40:28 INFO - TEST-START | kraken 02:40:28 INFO - operating with platform_type : linux_ 02:40:28 INFO - Initialising browser for kraken test... 02:40:28 INFO - TEST-INFO | started process 12565 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHkr9Gu/profile http://localhost:44583/getInfo.html) 02:40:33 INFO - PROCESS | 12565 | __metrics Screen width/height:1600/1200 02:40:33 INFO - PROCESS | 12565 | colorDepth:24 02:40:33 INFO - PROCESS | 12565 | Browser inner width/height: 1024/697 02:40:33 INFO - PROCESS | 12565 | __metrics 02:40:33 INFO - PROCESS | 12565 | 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" 02:40:33 INFO - PROCESS | 12565 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:40:34 INFO - PROCESS | 12565 | console.error: PushService: 02:40:34 INFO - PROCESS | 12565 | stateChangeProcessEnqueue: Error transitioning state 02:40:34 INFO - PROCESS | 12565 | UnknownError 02:40:35 INFO - TEST-INFO | 12565: exit 0 02:40:35 INFO - Browser initialized. 02:40:35 INFO - Running cycle 1/1 for kraken test... 02:40:35 INFO - TEST-INFO | started process 12648 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHkr9Gu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:40:47 INFO - PROCESS | 12648 | RSS: Main: 182636544 02:40:47 INFO - PROCESS | 12648 | 02:40:50 INFO - PROCESS | 12648 | Cycle 1(1): loaded http://localhost:44583/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44583/tests/kraken/driver.html?testName=audio-beat-detection) 02:40:51 INFO - PROCESS | 12648 | RSS: Main: 235667456 02:40:51 INFO - PROCESS | 12648 | 02:40:53 INFO - PROCESS | 12648 | Cycle 1(1): loaded http://localhost:44583/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44583/tests/kraken/driver.html?testName=audio-dft) 02:40:54 INFO - PROCESS | 12648 | RSS: Main: 225501184 02:40:54 INFO - PROCESS | 12648 | 02:40:57 INFO - PROCESS | 12648 | Cycle 1(1): loaded http://localhost:44583/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44583/tests/kraken/driver.html?testName=audio-fft) 02:40:58 INFO - PROCESS | 12648 | RSS: Main: 303607808 02:40:58 INFO - PROCESS | 12648 | 02:41:00 INFO - PROCESS | 12648 | Cycle 1(1): loaded http://localhost:44583/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44583/tests/kraken/driver.html?testName=audio-oscillator) 02:41:00 INFO - PROCESS | 12648 | RSS: Main: 214347776 02:41:00 INFO - PROCESS | 12648 | 02:41:03 INFO - PROCESS | 12648 | Cycle 1(1): loaded http://localhost:44583/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44583/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:41:03 INFO - PROCESS | 12648 | RSS: Main: 215314432 02:41:03 INFO - PROCESS | 12648 | 02:41:06 INFO - PROCESS | 12648 | Cycle 1(1): loaded http://localhost:44583/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44583/tests/kraken/driver.html?testName=imaging-darkroom) 02:41:07 INFO - PROCESS | 12648 | RSS: Main: 253562880 02:41:07 INFO - PROCESS | 12648 | 02:41:11 INFO - PROCESS | 12648 | Cycle 1(1): loaded http://localhost:44583/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44583/tests/kraken/driver.html?testName=imaging-desaturate) 02:41:11 INFO - PROCESS | 12648 | RSS: Main: 246644736 02:41:11 INFO - PROCESS | 12648 | 02:41:14 INFO - PROCESS | 12648 | Cycle 1(1): loaded http://localhost:44583/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44583/tests/kraken/driver.html?testName=json-parse-financial) 02:41:15 INFO - PROCESS | 12648 | RSS: Main: 251269120 02:41:15 INFO - PROCESS | 12648 | 02:41:17 INFO - PROCESS | 12648 | Cycle 1(1): loaded http://localhost:44583/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44583/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:41:17 INFO - PROCESS | 12648 | RSS: Main: 213618688 02:41:17 INFO - PROCESS | 12648 | 02:41:19 INFO - PROCESS | 12648 | Cycle 1(1): loaded http://localhost:44583/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44583/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:41:20 INFO - PROCESS | 12648 | RSS: Main: 221073408 02:41:20 INFO - PROCESS | 12648 | 02:41:22 INFO - PROCESS | 12648 | Cycle 1(1): loaded http://localhost:44583/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44583/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:41:23 INFO - PROCESS | 12648 | RSS: Main: 223076352 02:41:23 INFO - PROCESS | 12648 | 02:41:25 INFO - PROCESS | 12648 | Cycle 1(1): loaded http://localhost:44583/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44583/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:41:26 INFO - PROCESS | 12648 | RSS: Main: 224612352 02:41:26 INFO - PROCESS | 12648 | 02:41:29 INFO - PROCESS | 12648 | Cycle 1(1): loaded http://localhost:44583/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44583/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:41:30 INFO - PROCESS | 12648 | RSS: Main: 221999104 02:41:30 INFO - PROCESS | 12648 | 02:41:31 INFO - PROCESS | 12648 | Cycle 1(1): loaded http://localhost:44583/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44583/tests/kraken/driver.html?testName=ai-astar) 02:41:32 INFO - PROCESS | 12648 | RSS: Main: 273100800 02:41:32 INFO - PROCESS | 12648 | 02:41:32 INFO - PROCESS | 12648 | __start_tp_report 02:41:32 INFO - PROCESS | 12648 | _x_x_mozilla_page_load 02:41:32 INFO - PROCESS | 12648 | _x_x_mozilla_page_load_details 02:41:32 INFO - PROCESS | 12648 | |i|pagename|runs| 02:41:32 INFO - PROCESS | 12648 | |0;ai-astar;114;118;131;113;114;114;114;113;113;115 02:41:32 INFO - PROCESS | 12648 | |1;audio-beat-detection;150;122;155;184;128;158;149;125;189;126 02:41:32 INFO - PROCESS | 12648 | |2;audio-dft;161;161;162;160;162;161;162;162;163;161 02:41:32 INFO - PROCESS | 12648 | |3;audio-fft;76;75;76;165;77;76;75;76;156;75 02:41:32 INFO - PROCESS | 12648 | |4;audio-oscillator;84;85;145;83;84;84;134;82;82;138 02:41:32 INFO - PROCESS | 12648 | |5;imaging-gaussian-blur;118;118;118;118;118;118;118;117;118;118 02:41:32 INFO - PROCESS | 12648 | |6;imaging-darkroom;148;147;147;146;148;146;147;146;147;146 02:41:32 INFO - PROCESS | 12648 | |7;imaging-desaturate;96;95;96;95;96;95;95;95;96;94 02:41:32 INFO - PROCESS | 12648 | |8;json-parse-financial;66;65;65;65;65;65;65;66;64;64 02:41:32 INFO - PROCESS | 12648 | |9;json-stringify-tinderbox;67;66;66;65;67;67;67;65;66;66 02:41:32 INFO - PROCESS | 12648 | |10;stanford-crypto-aes;82;82;82;81;82;82;82;82;83;82 02:41:32 INFO - PROCESS | 12648 | |11;stanford-crypto-ccm;133;135;130;142;140;131;134;137;176;138 02:41:32 INFO - PROCESS | 12648 | |12;stanford-crypto-pbkdf2;171;170;171;172;168;168;168;171;179;175 02:41:32 INFO - PROCESS | 12648 | |13;stanford-crypto-sha256-iterative;69;68;75;68;68;68;72;69;67;68 02:41:32 INFO - PROCESS | 12648 | __end_tp_report 02:41:32 INFO - PROCESS | 12648 | __start_cc_report 02:41:32 INFO - PROCESS | 12648 | _x_x_mozilla_cycle_collect,1991 02:41:32 INFO - PROCESS | 12648 | __end_cc_report 02:41:32 INFO - PROCESS | 12648 | __startTimestamp1472722892064__endTimestamp 02:41:32 INFO - PROCESS | 12648 | 02:41:32 INFO - PROCESS | 12648 | ------- Summary: start ------- 02:41:32 INFO - PROCESS | 12648 | Number of tests: 14 02:41:32 INFO - PROCESS | 12648 | 02:41:32 INFO - PROCESS | 12648 | [#0] ai-astar Cycles:10 Average:115.90 Median:114.00 stddev:5.51 (4.8%) stddev-sans-first:5.80 02:41:32 INFO - PROCESS | 12648 | Values: 114.0 118.0 131.0 113.0 114.0 114.0 114.0 113.0 113.0 115.0 02:41:32 INFO - PROCESS | 12648 | 02:41:32 INFO - PROCESS | 12648 | [#1] audio-beat-detection Cycles:10 Average:148.60 Median:152.50 stddev:24.07 (15.8%) stddev-sans-first:25.53 02:41:32 INFO - PROCESS | 12648 | Values: 150.0 122.0 155.0 184.0 128.0 158.0 149.0 125.0 189.0 126.0 02:41:32 INFO - PROCESS | 12648 | 02:41:32 INFO - PROCESS | 12648 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 02:41:32 INFO - PROCESS | 12648 | Values: 161.0 161.0 162.0 160.0 162.0 161.0 162.0 162.0 163.0 161.0 02:41:32 INFO - PROCESS | 12648 | 02:41:32 INFO - PROCESS | 12648 | [#3] audio-fft Cycles:10 Average:92.70 Median:76.00 stddev:35.80 (47.1%) stddev-sans-first:37.46 02:41:32 INFO - PROCESS | 12648 | Values: 76.0 75.0 76.0 165.0 77.0 76.0 75.0 76.0 156.0 75.0 02:41:32 INFO - PROCESS | 12648 | 02:41:32 INFO - PROCESS | 12648 | [#4] audio-oscillator Cycles:10 Average:100.10 Median:83.50 stddev:26.99 (32.3%) stddev-sans-first:27.99 02:41:32 INFO - PROCESS | 12648 | Values: 84.0 85.0 145.0 83.0 84.0 84.0 134.0 82.0 82.0 138.0 02:41:32 INFO - PROCESS | 12648 | 02:41:32 INFO - PROCESS | 12648 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 02:41:32 INFO - PROCESS | 12648 | Values: 118.0 118.0 118.0 118.0 118.0 118.0 118.0 117.0 118.0 118.0 02:41:32 INFO - PROCESS | 12648 | 02:41:32 INFO - PROCESS | 12648 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.71 02:41:32 INFO - PROCESS | 12648 | Values: 148.0 147.0 147.0 146.0 148.0 146.0 147.0 146.0 147.0 146.0 02:41:32 INFO - PROCESS | 12648 | 02:41:32 INFO - PROCESS | 12648 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.50 stddev:0.67 (0.7%) stddev-sans-first:0.67 02:41:32 INFO - PROCESS | 12648 | Values: 96.0 95.0 96.0 95.0 96.0 95.0 95.0 95.0 96.0 94.0 02:41:32 INFO - PROCESS | 12648 | 02:41:32 INFO - PROCESS | 12648 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 02:41:32 INFO - PROCESS | 12648 | Values: 66.0 65.0 65.0 65.0 65.0 65.0 65.0 66.0 64.0 64.0 02:41:32 INFO - PROCESS | 12648 | 02:41:32 INFO - PROCESS | 12648 | [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:66.50 stddev:0.79 (1.2%) stddev-sans-first:0.78 02:41:32 INFO - PROCESS | 12648 | Values: 67.0 66.0 66.0 65.0 67.0 67.0 67.0 65.0 66.0 66.0 02:41:32 INFO - PROCESS | 12648 | 02:41:32 INFO - PROCESS | 12648 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:82.00 stddev:0.47 (0.6%) stddev-sans-first:0.50 02:41:32 INFO - PROCESS | 12648 | Values: 82.0 82.0 82.0 81.0 82.0 82.0 82.0 82.0 83.0 82.0 02:41:32 INFO - PROCESS | 12648 | 02:41:32 INFO - PROCESS | 12648 | [#11] stanford-crypto-ccm Cycles:10 Average:139.60 Median:137.50 stddev:13.34 (9.7%) stddev-sans-first:13.94 02:41:32 INFO - PROCESS | 12648 | Values: 133.0 135.0 130.0 142.0 140.0 131.0 134.0 137.0 176.0 138.0 02:41:32 INFO - PROCESS | 12648 | 02:41:32 INFO - PROCESS | 12648 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.30 Median:171.00 stddev:3.47 (2.0%) stddev-sans-first:3.67 02:41:32 INFO - PROCESS | 12648 | Values: 171.0 170.0 171.0 172.0 168.0 168.0 168.0 171.0 179.0 175.0 02:41:32 INFO - PROCESS | 12648 | 02:41:32 INFO - PROCESS | 12648 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:68.50 stddev:2.44 (3.6%) stddev-sans-first:2.59 02:41:32 INFO - PROCESS | 12648 | Values: 69.0 68.0 75.0 68.0 68.0 68.0 72.0 69.0 67.0 68.0 02:41:32 INFO - PROCESS | 12648 | -------- Summary: end -------- 02:41:32 INFO - PROCESS | 12648 | 02:41:33 INFO - TEST-INFO | 12648: exit 0 02:41:33 INFO - TEST-OK | kraken | took 65059ms 02:41:33 INFO - SUITE-END | took 1187s 02:41:33 INFO - Completed test suite (00:19:47) 02:41:33 INFO - javascript benchmark 02:41:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2571.138668546037, 2575.0858445251924, 2578.13632433135, 2584.9483010339795, 2597.3766296088934, 4480.753558554278, 4549.089734992425, 4565.086982603484, 4601.03378290559, 4655.930161047583, 4593.379893714347, 4604.194266003445, 4610.884727881805, 4653.208954477738, 4672.602828759559, 4299.226139294926, 4301.354796780477, 4304.677149213806, 4309.547497512763, 4369.847055353063, 4304.418903448026, 4331.328644060176, 4345.869623911288, 4359.149965756678, 4401.449818772653, 4347.60871521563, 4356.760378179199, 4378.912421751563, 4394.450693663292, 4406.272964960794, 4165.895852603679, 4212.010177608259, 4275.209086319041, 4317.15815415994, 4336.219480493525, 4155.750654960712, 4167.937480937789, 4183.811728472226, 4228.344606585953, 4245.660347172219, 4539.500654927955, 4590.380298659672, 4608.608268297199, 4610.654200934943, 4612.308153776927, 4782.880427989293, 4868.657397759195, 4883.0, 4888.657793954425, 4955.653104282702, 4872.220444728861, 4919.385076865392, 4940.678855874393, 4945.307656928033, 4949.430815456197, 4574.451065872084, 4586.633069354443, 4593.920428699253, 4601.723896566216, 4605.677602567788, 4866.853994380174, 5029.094762942632, 5034.546890779848, 5050.242463630411, 5063.949360506422, 4867.58625516835, 4868.659193856396, 4884.658073934862, 4941.950580494149, 4946.851594452172, 4988.052270068675, 5005.874853128701, 5006.249062640633, 5007.12375334315, 5069.721165335868, 4718.079974404958, 4759.214729569651, 4938.38270216223, 4947.035328110984, 5010.949890501121, 4808.735519546389, 4833.275008748646, 4844.2007068833955, 4893.6329775266995, 4912.778924948386, 4114.650254728322, 4121.052158003676, 4125.876223713293, 4130.091379896418, 4173.353130264813, 3628.455731640275, 3660.762050466711, 3676.8713095041544, 3682.024263570156, 3725.403935370382, 4094.836206551764, 4212.936805947913, 4274.166537525215, 4278.978605107017, 4326.394304797331, 4948.38145231846, 4993.151164302078, 4994.600431965434, 4996.975015124901, 5043.672161309577, 4266.765327906995, 4267.4025636410925, 4267.530571637118, 4268.59448352406, 4322.3516472528745, 4341.13177364522, 4434.512203657595, 4463.174312752151, 4474.7762611869275, 4534.274516077412, 4658.953410465852, 4675.76621168947, 4680.789364478538, 4731.7634118293945, 4744.098621261949, 4989.226669866177, 5001.42483614389, 5001.799928002839, 5004.3994720633755, 5057.949420505748, 4488.618467430174, 4640.141573808856, 4673.6494762892235, 4678.415198100238, 4696.1546921554445, 4920.827771027997, 4921.557059864629, 4922.532359425849, 4922.704637721748, 4976.651634385703, 4993.875153121201, 4996.3005179274205, 5002.949970500248, 5005.299258103942, 5006.249062640633, 4692.178868698033, 4749.097671442415, 4778.880527986828, 4782.713037217778, 4928.457869634266, 4763.595094416874, 4781.306710526885, 4786.617070634411, 4824.421069471686, 4831.0820944020525, 4667.579917807414, 4672.953270467252, 4673.532646735299, 4721.669483136147, 4758.547937945889, 4685.742284174266, 4736.668433209642, 4801.4958429364415, 4818.734969576707, 4819.759012049313, 4707.8587642370785, 4732.881677958078, 4739.1469535482565, 4779.904401912012, 4821.879453013703], "value": 4538.9415581329395, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.5057224356444, 570.0337927213372, 581.148617275691, 590.8463799412151, 593.0777640768606, 27203.863980680093, 38245.808770956144, 39257.60742392579, 39309.80345098278, 43162.35256471155, 39174.21651566974, 39313.80343098288, 39521.20957580847, 39581.40627890584, 39625.20749585007, 7612.92387076129, 7757.146713861499, 7764.844703105934, 7767.106782719975, 7767.6116194190345, 7522.9247707523045, 7590.089189297264, 7598.8480230395635, 7599.240075992412, 7613.162552119263, 7616.771496855104, 7638.3889288857035, 7657.387409007294, 7663.0, 7667.0, 7590.506617069873, 7620.885686714703, 7623.542587444771, 7624.885626715603, 7629.580373079479, 7681.155072941972, 7714.190010048977, 7746.302832745024, 7747.535147891144, 7751.8449631007625, 36769.63230367689, 37037.44443833345, 37043.814780925924, 37077.44383834245, 37088.25823483515, 2764.5991331256855, 2780.3605170810624, 2807.05963502227, 2868.942621147565, 3087.706667866549, 27539.31151721203, 27820.860895695594, 27876.581851272247, 27970.580441293194, 28133.0, 3370.713489353408, 3441.4149594568735, 3485.2506711057245, 3491.7555771096036, 3538.7169026478077, 269971.0, 271162.0, 272103.0, 272147.0, 272353.0, 30411.391772164432, 52562.0, 53104.0, 53126.20310695343, 53188.73405632947, 30588.0, 32490.350192996008, 32491.18772030671, 32514.0, 32535.837320813243, 13213.801792973112, 13437.86562134366, 13447.19316840973, 13449.260290684106, 13452.058355915187, 11043.171762117874, 11247.325160490396, 11267.267627604344, 11269.38018408979, 11279.266847654877, 7526.736564220226, 7590.620468976639, 7652.0, 7654.617269136521, 7655.540667559964, 2947.9705202948126, 2999.9550006749914, 3020.8489575521576, 3023.289526961162, 3035.5598438226334, 795.745361484331, 871.2376670413388, 875.6278581602793, 906.2523418180028, 945.1068740040733, 24435.87782061114, 25810.612840807404, 26159.346016349362, 26472.60291095635, 26572.202833915013, 746.2984794293346, 751.1849643137148, 793.3970182661104, 802.3741481644327, 954.8090381923504, 12725.236485810881, 12878.45972307278, 13074.215547067206, 13116.147450415692, 13201.141925774795, 383530.0, 388387.0, 388451.0, 390310.0, 391837.0, 47806.5219347809, 48227.0, 48262.51737482651, 48364.758176208896, 48438.75780621074, 1060.1412855587, 1153.233099988515, 1178.8290697848936, 1189.8869607387285, 1193.0813273779142, 25768.61347079758, 27560.724392755816, 28014.0, 28317.0, 28407.573886392132, 37437.81281093577, 37864.0, 37956.24087518289, 37997.0, 38008.619913801616, 281557.0, 281659.0, 282254.0, 282515.0, 283149.0, 21509.0, 23081.422964426023, 24097.638535421633, 24098.15656452016, 24103.276901692978, 37476.0, 37834.81082594679, 37934.62065379311, 38219.617803822715, 39407.80296098501, 33586.664133358354, 33758.49362259519, 33982.0, 34252.828735856165, 34331.65668343285, 32961.0, 33537.329253415286, 33617.83191084029, 33713.831430842685, 34068.829655851565, 33370.0, 33936.83031584826, 34109.0, 34225.14437139092, 34576.30847383088, 29838.254043648216, 31088.0, 31217.375652486367, 31616.525752114198, 31780.682193177774, 23678.171264006367, 23690.88154559216, 24161.0, 24311.51376972486, 25015.87492062528], "value": 15777.079105237988, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.89123480486256, 357.33000623830316, 363.9981800091, 365.3733846453332, 388.3340071776902, 12401.813972790404, 15517.456889008887, 15895.761563576541, 17555.122243887818, 17672.0, 16643.33426662935, 16902.239399227034, 16921.238544265507, 17011.744823827623, 17097.40159094432, 5036.874078148048, 5052.964142350827, 5143.794248230085, 5176.689398636075, 5188.558972487343, 3732.328180927432, 3934.7245692801516, 5107.719075450848, 5208.973955130238, 5209.609279304067, 3942.7634341939433, 3955.0507878109333, 5616.494515493605, 5986.970065149668, 5989.3112292086535, 5861.472467477947, 6042.395760423967, 6063.6361818290825, 6071.241094863142, 6072.574919755619, 5347.171188465794, 5347.812826551091, 5353.652012619167, 5366.490183432567, 5369.060414427459, 20028.899855500775, 20519.076641551164, 20519.692204616942, 20742.0, 20745.0, 1926.1332400419867, 1952.326447375653, 2127.638301488735, 2343.121329501437, 2519.344970307715, 12695.873041269562, 13199.604011879659, 13256.3371831409, 13376.352625831392, 13820.93089534556, 1596.5370042687607, 1632.5673696470444, 1637.2795969773263, 1638.7623794549843, 1685.3427163406282, 69011.65494172498, 69091.0, 70700.0, 73289.63355183243, 73675.0, 8408.32733381328, 8948.5078320693, 9070.092990700878, 9464.242860571137, 9583.808323833624, 11849.34828584419, 11917.523299068114, 11955.581554645545, 11966.700832479257, 11989.460474278678, 5636.887262254732, 5690.2033715279895, 5753.510951569164, 6066.696665166724, 7135.6432178391915, 6807.319268073252, 6811.2167100784045, 6839.62382068991, 7055.788326350115, 7068.787936361918, 3695.1870588470492, 3738.36447803874, 3749.4375843623675, 3832.463455116286, 3846.7307288489537, 1787.0156838080436, 1836.9448916532526, 1840.484664294, 1858.4053103006909, 1863.1708889544022, 807.9232472915064, 809.0816922792673, 830.2693629605908, 845.995770021146, 882.9757481321636, 16019.599510012344, 17415.825841741673, 17489.65020699579, 17600.64798704019, 17873.195706192993, 801.867691830853, 808.3573559020592, 816.5141740664295, 852.518327145161, 856.6958729651009, 8393.328533717287, 8808.427452215585, 9546.140847323773, 9675.564599593035, 9693.563789629483, 373620.0, 374695.0, 375068.0, 377874.0, 382101.0, 77162.0, 79116.20883791204, 79219.0, 79717.0, 79787.0, 854.7393045121298, 871.1201686296886, 873.0658195730507, 875.2560323724911, 881.352206128495, 14853.777193342325, 14920.792029713664, 15012.24938753036, 15036.0, 15576.92211538935, 25265.49469010646, 26090.086846961025, 35509.28981420409, 37955.48178072957, 39264.46619804231, 50307.74846125746, 50954.74522627512, 51385.7430712859, 51571.484285156665, 52534.0, 4892.730899800403, 6712.563683360566, 7516.624168791429, 7806.219378062148, 7948.562829044458, 9525.333226674065, 10543.31468454548, 11016.339019658846, 11418.200725949437, 12005.579804706793, 10039.0, 10067.446290454096, 10355.689329320132, 10465.68602941913, 10603.522841471999, 10035.749106272402, 10094.24293178, 10164.644237451654, 10209.030142136486, 10251.487425628839, 10122.139618132247, 10139.188864890644, 10263.58945642166, 10371.170306375623, 10426.791464170827, 6960.721571137098, 7056.329648683367, 7159.427245820218, 7220.927790722026, 7225.313595208447, 8280.378971577276, 10010.59957601717, 10098.596056157672, 10455.477226138815, 10584.417857017937], "value": 8014.255864250843, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1226.1662069792537, 1341.4902337111896, 1361.9659508512286, 1417.603071140081, 1662.3267576631467, 7268.890966635505, 7668.118166410864, 7717.575533345664, 7885.9211407885905, 7892.289693927545, 7682.270184332493, 7758.612069396536, 7772.6113694315345, 7783.961080194591, 7800.7269745558915, 1850.7594012778388, 2059.639563076463, 2194.3855720398315, 2226.7216597925258, 2227.354067320475, 2140.5825863956534, 2174.652055671093, 2180.923667671632, 2184.355615093551, 2190.4742861713235, 2175.042981088324, 2196.593630178414, 2201.9119235230573, 2222.344408399526, 2225.310153852303, 2045.70337301092, 2079.1579410338836, 2089.2374283386453, 2097.685347197917, 2137.2519618133683, 2162.967555486669, 2173.8913054347217, 2175.6627722702847, 2175.760666326703, 2183.5087105401317, 7617.085949686073, 7647.541147531166, 7654.732084377076, 7657.387409007321, 7659.7319093832, 4330.2638551446325, 4437.977810110961, 4441.178381999341, 4451.799669014902, 4454.554544545552, 2834.702356252605, 2865.068852622906, 3003.3242520432946, 3017.607710997578, 3022.22933152047, 970.2141265574836, 985.2856678907806, 996.2528103922059, 1006.6124542051363, 1011.5245834457793, 10255.846162307571, 10480.68557943263, 10486.318389304672, 10494.265401421904, 10515.894841051568, 4119.0937993641355, 4147.108371700099, 4306.375575541529, 4311.116221174651, 4338.696291259582, 8538.786530336667, 8543.316534677335, 8547.0, 8551.871721924175, 8554.529500877512, 4604.056168485453, 4604.953950460453, 4605.769711514478, 4606.424196975378, 4613.515580864028, 3335.6164041135094, 4033.8184781684895, 4119.9176016480105, 4126.463559737215, 4133.2146892091005, 3608.80151591665, 3614.1868079682386, 3723.2181241938956, 3740.6259374062374, 3744.4383342498845, 1168.9941550292365, 1172.0974849365941, 1174.0431548288118, 1175.2419689300352, 1178.9823152652716, 619.5260625621403, 631.5452873930763, 655.4199533412964, 721.3147509865648, 734.8420089680744, 4789.233722604366, 4969.428515720666, 5090.211017292326, 5271.920921186185, 5311.601629877775, 730.7625021867914, 756.8864670299389, 846.3356265331685, 885.3536918049859, 970.257752819094, 3640.10817349751, 3820.9617903821163, 3888.922221555553, 3937.1731936293127, 3965.4844870166694, 9504.287178461644, 9529.380590261611, 9636.566354514063, 9652.75868103303, 9689.0, 8882.822343553222, 9483.762905927408, 9561.235101191887, 9569.952150239204, 9577.23382129442, 6999.615021173782, 7328.59692716895, 7336.889946650805, 7344.30229128232, 7351.3751331137455, 5079.44126146131, 5241.659292146151, 5250.26496290512, 5351.5451186648015, 5501.064818980863, 8504.617292221741, 8637.827243455222, 8752.299816014576, 8920.330975177018, 8969.730908072768, 8782.473051616924, 8994.100589940954, 9056.27549796028, 9070.727878163665, 9089.272858171198, 5723.7996670116345, 5959.40405959418, 5961.314448838439, 6342.619442833445, 6425.325340839145, 6603.867922641424, 6687.1975362956755, 6791.66041697923, 6820.35206655367, 6926.168859736864, 6273.811785646438, 6372.617642941438, 6412.6793660317735, 6526.347365263436, 6529.640869752209, 5935.673537955454, 5976.731047102804, 6051.818445446644, 6058.151858739868, 6065.0, 6012.939870601238, 6136.662483563447, 6145.508359331332, 6145.84635384119, 6146.754129834757, 4376.9124617508105, 4477.70894891831, 4479.0, 4551.135284295973, 4628.814847406066, 4304.268274393423, 4321.891952701208, 4359.433273674402, 4370.825166993284, 4470.307102399133], "value": 4037.3051124171725, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [273.08652557196183, 283.2663401789365, 283.9843808590527, 297.6844544782531, 303.65686773945436, 4674.4624368197665, 4746.454157771857, 4751.382320298365, 4755.167845627015, 4776.2297867237, 4610.294191149271, 4651.162790697673, 4682.321063445798, 4685.2269375553, 4737.43150821901, 3483.581970163578, 3568.2149927016017, 3695.1870588470492, 3704.7033538261526, 3719.293334266494, 3689.114612492996, 3717.237966216919, 3734.1038150843738, 3735.8879233622897, 3741.877436768972, 3637.4725664778593, 3638.4349033931016, 3644.2529281497227, 3689.8155092245415, 3693.926121477569, 3469.3755124077657, 3562.4656301554846, 3635.800030998294, 3668.9633103669157, 3703.4444833275224, 3250.8699652013893, 3271.1331497153274, 3274.6889045540634, 3279.1310302769784, 3304.0, 4539.773011349453, 4551.226291530448, 4556.179887620227, 4569.405977222973, 4622.8150873965005, 3959.4852669152824, 4223.176480586287, 4231.196072746168, 4232.682548808852, 4234.242789242491, 4862.927056094161, 4885.413750349981, 4886.926696099561, 4905.994271174401, 4923.144576145827, 3616.367135751233, 3622.605296960689, 3622.800745958971, 3623.148560088377, 3632.929230338708, 4932.260160975882, 5124.923126153073, 5153.587712982952, 5169.327987361657, 5197.870053248661, 3615.3311637347174, 3631.1466805300734, 3655.61616030313, 3665.5337864854273, 3668.5414323209598, 3750.962490375116, 3755.6807671347697, 3759.793211373401, 3760.7555508891833, 3765.1904840459433, 4216.325387937915, 4219.78901054946, 4230.344296633965, 4230.767307798101, 4232.153569286093, 4770.403699537558, 4863.8540843774745, 4892.119418504632, 4963.950360496421, 4978.850634480971, 1270.7585558743808, 1276.6489215465822, 1277.9329260067761, 1287.2598256002836, 1299.7205600795874, 784.7724159993538, 807.6930766308765, 814.3932770086324, 821.1131977464324, 833.5662660224405, 4148.639601922452, 4285.400043993844, 4285.807138678767, 4288.185244803477, 4302.22559939214, 4969.478204788517, 4976.850694479172, 4982.427020892571, 4983.6760610560195, 5014.247862820606, 4290.15523324967, 4295.312749959991, 4307.612314891675, 4307.784610769449, 4310.599055307038, 2502.349389158832, 2627.316897606636, 2632.7104018557943, 2634.76287134155, 2637.5384307746067, 4675.742834144155, 4692.976535117303, 4703.717776933395, 4717.292406139107, 4719.858404247878, 5093.23601459784, 5110.540051395392, 5127.820526281562, 5128.9230661540105, 5129.7178655173575, 4469.664775141878, 4733.337332773414, 4738.218193998021, 4769.594584460221, 4772.498887616889, 5066.0, 5067.429096979948, 5072.315237442898, 5074.923876141935, 5085.745712714275, 4797.313504437526, 4947.628927830355, 4955.207166853286, 4974.626902982219, 4987.775550100182, 4751.738654374042, 4776.952230477651, 4779.211430114131, 4779.665423420327, 4782.497837727128, 3621.4567814827988, 3625.1480901987484, 3629.147150419702, 3635.8727444539313, 3638.308721342936, 5030.57240134578, 5049.636598118561, 5051.520105589963, 5061.190209566452, 5068.569171620454, 4787.593054590398, 4878.804847806048, 4899.6570240084275, 4906.282801019614, 4930.6795058321095, 4925.0, 4931.235658472942, 4939.604831613534, 4940.160172770566, 4940.481249468898, 4856.1987272099705, 4860.416749990024, 4862.173430516891, 4865.416150062015, 4867.367242258484, 4663.743494107856, 4905.828296009765, 4919.926201106915, 4935.777889994887, 4936.148944145945, 4825.324454576432, 4832.371791667061, 4834.187179807572, 4840.29815676732, 4844.128056949642], "value": 3709.3126629844073, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.8171566814287, 643.9710213040413, 653.2063542795509, 664.2294937872069, 665.4908994619117, 11989.820152697706, 12153.878461215396, 12177.0, 12320.691982700437, 12902.161359511638, 12907.096503244753, 13056.477740890354, 13076.150050246728, 13077.67305817355, 13087.541936032241, 605.7213681706398, 731.5939653492323, 746.5781833264216, 746.6640011994624, 746.7498388039986, 729.5403895545799, 761.8323968726899, 766.0118447203101, 767.5548182054395, 768.5465575310566, 792.053496072194, 794.3962588432804, 794.7854079398559, 794.8370584030259, 794.9562774047425, 630.1839118341712, 789.7907054630527, 789.893364395805, 789.9999999999972, 790.0479921694345, 564.1932037186821, 580.6371018113679, 581.584167320368, 583.3816154875846, 583.7781642975684, 11341.26281791681, 11344.886551134465, 11360.715982100432, 11407.54369825206, 11432.485538150802, 12058.517659293619, 12358.134930554865, 12469.251844889335, 12705.237685738794, 12707.745845083047, 11713.824292635618, 11772.70568235801, 12075.57735479254, 12188.81716774249, 12433.0, 4132.483439570054, 4136.9793151034355, 4198.475190601175, 4301.505326887385, 4354.129174165148, 62726.0, 63530.68234658843, 64302.0, 64465.03302450514, 64580.0, 9777.31558790892, 9975.401475911323, 10236.232282578836, 10409.635662751767, 10560.47197640115, 16341.673166536602, 16522.75215871763, 16527.256273467723, 16532.256048477848, 16533.256003479873, 6275.1842260506755, 6305.3379395163765, 6415.0, 6466.967665161644, 6537.34626537352, 3482.59950105736, 3573.3746594345885, 3598.568171819346, 3620.728445366608, 3657.707383409374, 2557.360659835041, 2617.7120516743144, 2642.0, 2642.2997905555044, 2654.018013335078, 475.58148829030233, 476.92130798418566, 521.1869483605587, 532.4010488200774, 554.5341912793273, 479.64745911754835, 481.65320968902336, 572.9885402291931, 573.2032474859948, 583.5331734612294, 7477.476576639692, 7970.402219833536, 8173.264406203471, 8402.285805706584, 8430.367722420842, 479.85364463838164, 508.6439492355292, 545.9672419654834, 555.9138333558305, 573.761888816145, 3850.114473671071, 3953.723239373216, 3968.9603103969166, 3975.8012099394914, 4028.516578010599, 54680.45319546833, 84759.0, 98333.0, 98444.50777746065, 104712.0, 68133.0, 85621.57189214014, 88408.5579572098, 89779.55110224408, 90205.09794901968, 49307.75346123247, 63346.68326658337, 63799.0, 71865.64067179631, 72889.0, 7157.821054473679, 8128.918710812816, 8252.917470825216, 8256.298214651822, 8324.70863519774, 35236.47145292771, 40353.39469908013, 42833.0, 43859.561404385546, 45562.54437455583, 55897.1219835074, 63304.0, 65053.349466504726, 65356.673216633615, 66258.66870665616, 10027.799444010932, 10381.273310868166, 10617.203709721647, 11088.279261847954, 11407.714807129889, 11798.351090690094, 11817.645470635895, 11907.285562866256, 12208.084393670688, 12225.08311876595, 10206.744831379276, 10237.897621023694, 10409.219308551737, 10555.94722026385, 10750.892491075301, 11533.480993355486, 12284.447199876206, 12297.877021229673, 12324.568640097554, 12341.136120471481, 9649.517524123907, 9659.372140810825, 10215.846762298721, 10240.129588985019, 10245.231607629308, 9966.750831228986, 10143.847842282225, 10374.740631484274, 10599.804222629728, 10729.088027517748, 9310.581023853807, 9810.705678829647, 10180.185585153318, 10185.08334249921, 10206.285560010729], "value": 6335.562706790636, "unit": "score"}], "name": "dromaeo_css", "value": 6156.638553523692, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 118.0, 131.0, 113.0, 114.0, 114.0, 114.0, 113.0, 113.0, 115.0], "value": 115.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 122.0, 155.0, 184.0, 128.0, 158.0, 149.0, 125.0, 189.0, 126.0], "value": 148.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 160.0, 162.0, 161.0, 162.0, 162.0, 163.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 165.0, 77.0, 76.0, 75.0, 76.0, 156.0, 75.0], "value": 92.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 145.0, 83.0, 84.0, 84.0, 134.0, 82.0, 82.0, 138.0], "value": 100.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 118.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 146.0, 148.0, 146.0, 147.0, 146.0, 147.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 94.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 66.0, 64.0, 64.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 65.0, 67.0, 67.0, 67.0, 65.0, 66.0, 66.0], "value": 66.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 82.0, 81.0, 82.0, 82.0, 82.0, 82.0, 83.0, 82.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 135.0, 130.0, 142.0, 140.0, 131.0, 134.0, 137.0, 176.0, 138.0], "value": 139.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 170.0, 171.0, 172.0, 168.0, 168.0, 168.0, 171.0, 179.0, 175.0], "value": 171.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 75.0, 68.0, 68.0, 68.0, 72.0, 69.0, 67.0, 68.0], "value": 69.2, "unit": "score"}], "name": "kraken", "value": 1572.1, "alertThreshold": 2.0}]} 02:41:33 INFO - Return code: 0 02:41:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:41:33 INFO - # TBPL SUCCESS # 02:41:33 INFO - Running post-action listener: _resource_record_post_action 02:41:33 INFO - [mozharness: 2016-09-01 09:41:33.873742Z] Finished run-tests step (success) 02:41:33 INFO - Running post-run listener: _resource_record_post_run 02:41:33 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 416645120; Read time: 8; Write time: 278636 02:41:33 INFO - TinderboxPrint: CPU usage
13.0% 02:41:33 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 02:41:33 INFO - TinderboxPrint: I/O write bytes / time
416,645,120 / 278,636 02:41:33 INFO - TinderboxPrint: CPU idle
8,355.2 (87.0%) 02:41:33 INFO - TinderboxPrint: CPU user
1,201.5 (12.5%) 02:41:33 INFO - TinderboxPrint: Swap in / out
0 / 0 02:41:33 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 125116416; Read time: 0; Write time: 91024 02:41:33 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 290500608; Read time: 0; Write time: 187468 02:41:34 INFO - Running post-run listener: _upload_blobber_files 02:41:34 INFO - Blob upload gear active. 02:41:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:41:34 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 02:41:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:41:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:41:34 INFO - (blobuploader) - INFO - Open directory for files ... 02:41:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:41:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:41:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:41:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:41:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:41:43 INFO - (blobuploader) - INFO - Done attempting. 02:41:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:41:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:41:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:41:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:41:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:41:43 INFO - (blobuploader) - INFO - Done attempting. 02:41:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:41:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:41:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:41:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:41:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:41:44 INFO - (blobuploader) - INFO - Done attempting. 02:41:44 INFO - (blobuploader) - INFO - Iteration through files over. 02:41:44 INFO - Return code: 0 02:41:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:41:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:41:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/02dab7829ceb0589bca43488d09b2082826f4d93075b8631ab4d31d8a8fb0c29718c5d4e2be20e68cfbd02667c7db7ff847a773595e8e25b51e6844fc8cb16f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/64c1895a7e5485ecb8fbdcb992b4eeb7eb4668570fb7b63f6644d2f9c42721ca8f691bde3ffaa4badc9a68bfbc7fef1163ee8a86d527d5838130a737918d6185", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bfafeb9e34a02581c8a37d2d4fd5331f0b8fd41464ba05df82618364fab096b7650cca746c60c7aa16df4b129488bfb25025ca4cc9fe726831e908a81ca89415"} 02:41:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:41:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:41:44 INFO - Contents: 02:41:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/02dab7829ceb0589bca43488d09b2082826f4d93075b8631ab4d31d8a8fb0c29718c5d4e2be20e68cfbd02667c7db7ff847a773595e8e25b51e6844fc8cb16f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/64c1895a7e5485ecb8fbdcb992b4eeb7eb4668570fb7b63f6644d2f9c42721ca8f691bde3ffaa4badc9a68bfbc7fef1163ee8a86d527d5838130a737918d6185", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bfafeb9e34a02581c8a37d2d4fd5331f0b8fd41464ba05df82618364fab096b7650cca746c60c7aa16df4b129488bfb25025ca4cc9fe726831e908a81ca89415"} 02:41:44 INFO - Running post-run listener: copy_logs_to_upload_dir 02:41:44 INFO - Copying logs to upload dir... 02:41:44 INFO - mkdir: /builds/slave/test/build/upload/logs 02:41:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.610787 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-09-01 02:41:44.601845) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 02:41:44.605504) ========= 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=db0483c52d987ecb441a263b000001ad-1472721272.115553-159134206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/02dab7829ceb0589bca43488d09b2082826f4d93075b8631ab4d31d8a8fb0c29718c5d4e2be20e68cfbd02667c7db7ff847a773595e8e25b51e6844fc8cb16f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/64c1895a7e5485ecb8fbdcb992b4eeb7eb4668570fb7b63f6644d2f9c42721ca8f691bde3ffaa4badc9a68bfbc7fef1163ee8a86d527d5838130a737918d6185", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bfafeb9e34a02581c8a37d2d4fd5331f0b8fd41464ba05df82618364fab096b7650cca746c60c7aa16df4b129488bfb25025ca4cc9fe726831e908a81ca89415"} build_url:https://queue.taskcluster.net/v1/task/b2BCI4rkSmiO8hQL-mCKjA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011403 build_url: 'https://queue.taskcluster.net/v1/task/b2BCI4rkSmiO8hQL-mCKjA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/02dab7829ceb0589bca43488d09b2082826f4d93075b8631ab4d31d8a8fb0c29718c5d4e2be20e68cfbd02667c7db7ff847a773595e8e25b51e6844fc8cb16f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/64c1895a7e5485ecb8fbdcb992b4eeb7eb4668570fb7b63f6644d2f9c42721ca8f691bde3ffaa4badc9a68bfbc7fef1163ee8a86d527d5838130a737918d6185", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bfafeb9e34a02581c8a37d2d4fd5331f0b8fd41464ba05df82618364fab096b7650cca746c60c7aa16df4b129488bfb25025ca4cc9fe726831e908a81ca89415"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 02:41:44.633057) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 02:41:44.633506) ========= 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=db0483c52d987ecb441a263b000001ad-1472721272.115553-159134206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004516 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 02:41:44.717924) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 02:41:44.718279) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 02:41:44.718750) ========= ========= Total master_lag: 0.17 =========