builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-051 starttime: 1471906145.83 results: success (0) buildid: 20160822145214 builduid: bfa0b3d7dfdb4689b676509060d68745 revision: 3e537d8eb88c440fd0b7aa88deec56aa688715b0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 15:49:05.828133) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 15:49:05.828649) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 15:49:05.828948) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 15:49:05.843767) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 15:49:05.844104) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1471906145.370864-1644060607 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-22 15:49:06-- 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% 51.0M=0s 2016-08-22 15:49:06 (51.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104168 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 15:49:05.962563) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 15:49:05.962873) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1471906145.370864-1644060607 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018559 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 15:49:06.014499) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 15:49:06.014955) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3e537d8eb88c440fd0b7aa88deec56aa688715b0 --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 3e537d8eb88c440fd0b7aa88deec56aa688715b0 --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=5ac5dba3e01a12f1ff77ab15000001b1-1471906145.370864-1644060607 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-22 15:49:06,418 truncating revision to first 12 chars 2016-08-22 15:49:06,418 Setting DEBUG logging. 2016-08-22 15:49:06,418 attempt 1/10 2016-08-22 15:49:06,418 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3e537d8eb88c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-22 15:49:07,037 unpacking tar archive at: fx-team-3e537d8eb88c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.969866 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 15:49:06.998620) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 15:49:06.998967) ========= script_repo_revision: 3e537d8eb88c440fd0b7aa88deec56aa688715b0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 15:49:06.999360) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 15:49:06.999621) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 15:49:07.010143) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-08-22 15:49:07.010481) ========= /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=5ac5dba3e01a12f1ff77ab15000001b1-1471906145.370864-1644060607 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:49:07 INFO - MultiFileLogger online at 20160822 15:49:07 in /builds/slave/test 15:49:07 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 15:49:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:49:07 INFO - {'append_to_log': False, 15:49:07 INFO - 'base_work_dir': '/builds/slave/test', 15:49:07 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:49:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:49:07 INFO - 'branch': 'Fx-Team-Non-PGO', 15:49:07 INFO - 'buildbot_json_path': 'buildprops.json', 15:49:07 INFO - 'config_files': ('talos/linux_config.py',), 15:49:07 INFO - 'default_actions': ('clobber', 15:49:07 INFO - 'read-buildbot-config', 15:49:07 INFO - 'download-and-extract', 15:49:07 INFO - 'populate-webroot', 15:49:07 INFO - 'create-virtualenv', 15:49:07 INFO - 'install', 15:49:07 INFO - 'run-tests'), 15:49:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:49:07 INFO - 'download_minidump_stackwalk': True, 15:49:07 INFO - 'download_symbols': 'ondemand', 15:49:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:49:07 INFO - 'tooltool.py': '/tools/tooltool.py', 15:49:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:49:07 INFO - '/tools/misc-python/virtualenv.py')}, 15:49:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:49:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:49:07 INFO - 'installer_path': 'installer.exe', 15:49:07 INFO - 'log_level': 'info', 15:49:07 INFO - 'log_name': 'talos', 15:49:07 INFO - 'log_to_console': True, 15:49:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:49:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:49:07 INFO - 'opt_config_files': (), 15:49:07 INFO - 'pip_index': False, 15:49:07 INFO - 'sps_profile': False, 15:49:07 INFO - 'sps_profile_interval': 0, 15:49:07 INFO - 'suite': 'dromaeojs', 15:49:07 INFO - 'system_bits': '32', 15:49:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:49:07 INFO - 'title': 'talos-linux64-ix-051', 15:49:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:49:07 INFO - 'use_talos_json': True, 15:49:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:49:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:49:07 INFO - 'work_dir': 'build'} 15:49:07 INFO - [mozharness: 2016-08-22 22:49:07.510591Z] Running clobber step. 15:49:07 INFO - Running pre-action listener: _resource_record_pre_action 15:49:07 INFO - Running main action method: clobber 15:49:07 INFO - rmtree: /builds/slave/test/build 15:49:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:49:07 INFO - Running post-action listener: _resource_record_post_action 15:49:07 INFO - [mozharness: 2016-08-22 22:49:07.970008Z] Finished clobber step (success) 15:49:07 INFO - [mozharness: 2016-08-22 22:49:07.970109Z] Running read-buildbot-config step. 15:49:07 INFO - Running pre-action listener: _resource_record_pre_action 15:49:07 INFO - Running main action method: read_buildbot_config 15:49:07 INFO - Using buildbot properties: 15:49:07 INFO - { 15:49:07 INFO - "project": "", 15:49:07 INFO - "product": "firefox", 15:49:07 INFO - "script_repo_revision": "production", 15:49:07 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:49:07 INFO - "repository": "", 15:49:07 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 15:49:07 INFO - "buildid": "20160822145214", 15:49:07 INFO - "pgo_build": "False", 15:49:07 INFO - "basedir": "/builds/slave/test", 15:49:07 INFO - "buildnumber": 1877, 15:49:07 INFO - "slavename": "talos-linux64-ix-051", 15:49:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:49:07 INFO - "platform": "ubuntu64_hw", 15:49:07 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:49:07 INFO - "branch": "fx-team", 15:49:07 INFO - "repo_path": "integration/fx-team", 15:49:07 INFO - "revision": "3e537d8eb88c440fd0b7aa88deec56aa688715b0", 15:49:07 INFO - "stage_platform": "linux64", 15:49:07 INFO - "builduid": "bfa0b3d7dfdb4689b676509060d68745", 15:49:07 INFO - "slavebuilddir": "test" 15:49:07 INFO - } 15:49:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/T4J-7ohwSdGP-I9a6YvoMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 15:49:07 INFO - Running post-action listener: _resource_record_post_action 15:49:07 INFO - [mozharness: 2016-08-22 22:49:07.972533Z] Finished read-buildbot-config step (success) 15:49:07 INFO - [mozharness: 2016-08-22 22:49:07.972621Z] Running download-and-extract step. 15:49:07 INFO - Running pre-action listener: _resource_record_pre_action 15:49:07 INFO - Running main action method: download_and_extract 15:49:07 INFO - mkdir: /builds/slave/test/build/tests 15:49:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:07 INFO - trying https://queue.taskcluster.net/v1/task/T4J-7ohwSdGP-I9a6YvoMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 15:49:07 INFO - Downloading https://queue.taskcluster.net/v1/task/T4J-7ohwSdGP-I9a6YvoMg/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 15:49:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T4J-7ohwSdGP-I9a6YvoMg/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 15:49:08 INFO - Downloaded 1361 bytes. 15:49:08 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 15:49:08 INFO - Using the following test package requirements: 15:49:08 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 15:49:08 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:49:08 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:49:08 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:49:08 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:49:08 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:49:08 INFO - u'jsshell-linux-x86_64.zip'], 15:49:08 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:49:08 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:49:08 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 15:49:08 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:49:08 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:49:08 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:49:08 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:49:08 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:49:08 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:49:08 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:49:08 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:49:08 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:49:08 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')]} 15:49:08 INFO - trying https://queue.taskcluster.net/v1/task/T4J-7ohwSdGP-I9a6YvoMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:49:08 INFO - Downloading https://queue.taskcluster.net/v1/task/T4J-7ohwSdGP-I9a6YvoMg/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 15:49:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T4J-7ohwSdGP-I9a6YvoMg/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 15:49:09 INFO - Downloaded 20330904 bytes. 15:49:09 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 15:49:13 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 15:49: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')]} 15:49:13 INFO - trying https://queue.taskcluster.net/v1/task/T4J-7ohwSdGP-I9a6YvoMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:49:13 INFO - Downloading https://queue.taskcluster.net/v1/task/T4J-7ohwSdGP-I9a6YvoMg/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 15:49:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T4J-7ohwSdGP-I9a6YvoMg/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 15:49:14 INFO - Downloaded 20330904 bytes. 15:49:14 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 15:49:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:19 INFO - trying https://queue.taskcluster.net/v1/task/T4J-7ohwSdGP-I9a6YvoMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 15:49:19 INFO - Downloading https://queue.taskcluster.net/v1/task/T4J-7ohwSdGP-I9a6YvoMg/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 15:49:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T4J-7ohwSdGP-I9a6YvoMg/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 15:49:19 INFO - Downloaded 14413981 bytes. 15:49:19 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 15:49:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:20 INFO - trying https://queue.taskcluster.net/v1/task/T4J-7ohwSdGP-I9a6YvoMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:49:20 INFO - Downloading https://queue.taskcluster.net/v1/task/T4J-7ohwSdGP-I9a6YvoMg/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 15:49:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T4J-7ohwSdGP-I9a6YvoMg/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 15:49:21 INFO - Downloaded 55764349 bytes. 15:49:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T4J-7ohwSdGP-I9a6YvoMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:49:21 INFO - mkdir: /builds/slave/test/properties 15:49:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:49:21 INFO - Writing to file /builds/slave/test/properties/build_url 15:49:21 INFO - Contents: 15:49:21 INFO - build_url:https://queue.taskcluster.net/v1/task/T4J-7ohwSdGP-I9a6YvoMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:49:21 INFO - Running post-action listener: _resource_record_post_action 15:49:21 INFO - Running post-action listener: set_extra_try_arguments 15:49:21 INFO - [mozharness: 2016-08-22 22:49:21.824332Z] Finished download-and-extract step (success) 15:49:21 INFO - [mozharness: 2016-08-22 22:49:21.824555Z] Running populate-webroot step. 15:49:21 INFO - Running pre-action listener: _resource_record_pre_action 15:49:21 INFO - Running main action method: populate_webroot 15:49:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:49:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:49:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:49:21 INFO - '--tppagecycles', 15:49:21 INFO - '7'], 15:49:21 INFO - 'tests': ['tsvgm']}}, 15:49:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:49:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:49:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:49:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:49:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:49:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:49:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:49:21 INFO - 'talos_options': ['--disable-e10s'], 15:49:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:49:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:49:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:49:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:49:21 INFO - 'talos_options': ['--disable-e10s'], 15:49:21 INFO - 'tests': ['damp', 'tps']}, 15:49:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:49:21 INFO - 'tests': ['damp', 'tps']}, 15:49:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:49:21 INFO - 'tests': ['dromaeo_dom']}, 15:49:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:49:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:49:21 INFO - 'tests': ['basic_compositor_video']}, 15:49:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:49:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:49:21 INFO - 'tests': ['a11yr', 15:49:21 INFO - 'ts_paint', 15:49:21 INFO - 'tpaint', 15:49:21 INFO - 'sessionrestore', 15:49:21 INFO - 'sessionrestore_no_auto_restore', 15:49:21 INFO - 'tabpaint']}, 15:49:21 INFO - 'other-e10s': {'tests': ['a11yr', 15:49:21 INFO - 'ts_paint', 15:49:21 INFO - 'tpaint', 15:49:21 INFO - 'sessionrestore', 15:49:21 INFO - 'sessionrestore_no_auto_restore', 15:49:21 INFO - 'tabpaint']}, 15:49:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:49:21 INFO - 'ts_paint', 15:49:21 INFO - 'tpaint', 15:49:21 INFO - 'sessionrestore', 15:49:21 INFO - 'sessionrestore_no_auto_restore', 15:49:21 INFO - 'tabpaint']}, 15:49:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:49:21 INFO - 'ts_paint', 15:49:21 INFO - 'tpaint', 15:49:21 INFO - 'sessionrestore', 15:49:21 INFO - 'sessionrestore_no_auto_restore', 15:49:21 INFO - 'tabpaint']}, 15:49:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:49:21 INFO - 'tests': ['a11yr', 15:49:21 INFO - 'ts_paint', 15:49:21 INFO - 'tpaint', 15:49:21 INFO - 'sessionrestore', 15:49:21 INFO - 'sessionrestore_no_auto_restore', 15:49:21 INFO - 'tabpaint']}, 15:49:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:49:21 INFO - 'tests': ['a11yr', 15:49:21 INFO - 'ts_paint', 15:49:21 INFO - 'tpaint', 15:49:21 INFO - 'sessionrestore', 15:49:21 INFO - 'sessionrestore_no_auto_restore', 15:49:21 INFO - 'tabpaint']}, 15:49:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:49:21 INFO - 'tests': ['tsvgx', 15:49:21 INFO - 'tsvgr_opacity', 15:49:21 INFO - 'tart', 15:49:21 INFO - 'tscrollx', 15:49:21 INFO - 'cart']}, 15:49:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:49:21 INFO - 'tsvgr_opacity', 15:49:21 INFO - 'tart', 15:49:21 INFO - 'tscrollx', 15:49:21 INFO - 'cart']}, 15:49:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:49:21 INFO - 'talos_options': ['--disable-e10s'], 15:49:21 INFO - 'tests': ['tp5o']}, 15:49:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:49:21 INFO - 'tests': ['tp5o']}, 15:49:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:49:21 INFO - 'talos_options': ['--disable-e10s', 15:49:21 INFO - '--xperf_path', 15:49:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:49:21 INFO - 'tests': ['tp5n']}, 15:49:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:49:21 INFO - 'talos_options': ['--xperf_path', 15:49:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:49:21 INFO - 'tests': ['tp5n']}}, 15:49:21 INFO - 'talos.zip': {'path': '', 15:49:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:49:21 INFO - Running post-action listener: _resource_record_post_action 15:49:21 INFO - [mozharness: 2016-08-22 22:49:21.845680Z] Finished populate-webroot step (success) 15:49:21 INFO - [mozharness: 2016-08-22 22:49:21.845768Z] Running create-virtualenv step. 15:49:21 INFO - Running pre-action listener: _resource_record_pre_action 15:49:21 INFO - Running main action method: create_virtualenv 15:49:21 INFO - Creating virtualenv /builds/slave/test/build/venv 15:49:21 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 15:49:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:49:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:49:21 INFO - Using real prefix '/usr' 15:49:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:49:22 INFO - Installing distribute.............................................................................................................................................................................................done. 15:49:24 INFO - Installing pip.................done. 15:49:24 INFO - Return code: 0 15:49:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:49:24 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')]} 15:49:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:24 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')]} 15:49:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:24 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 0x7f39d8b14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21e0230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21da090>, '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 0x21dd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21dde40>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1471906145.370864-1644060607', '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 15:49:24 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 15:49:24 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 15:49:24 INFO - Using env: {'DISPLAY': ':0', 15:49:24 INFO - 'HOME': '/home/cltbld', 15:49:24 INFO - 'LANG': 'en_US.UTF-8', 15:49:24 INFO - 'LANGUAGE': 'en_US:en', 15:49:24 INFO - 'LOGNAME': 'cltbld', 15:49:24 INFO - 'MAIL': '/var/mail/cltbld', 15:49:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:24 INFO - 'MOZ_NO_REMOTE': '1', 15:49:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:24 INFO - 'NO_EM_RESTART': '1', 15:49:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:24 INFO - 'PWD': '/builds/slave/test', 15:49:24 INFO - 'SHELL': '/bin/bash', 15:49:24 INFO - 'SHLVL': '1', 15:49:24 INFO - 'TERM': 'linux', 15:49:24 INFO - 'TMOUT': '86400', 15:49:24 INFO - 'USER': 'cltbld', 15:49:24 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1471906145.370864-1644060607', 15:49:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:24 INFO - '_': '/tools/buildbot/bin/python'} 15:49:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:24 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 15:49:24 INFO - Cleaning up... 15:49:24 INFO - Return code: 0 15:49:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:49:24 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')]} 15:49:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:24 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')]} 15:49:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:24 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 0x7f39d8b14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21e0230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21da090>, '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 0x21dd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21dde40>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1471906145.370864-1644060607', '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 15:49:24 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 15:49:24 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 15:49:24 INFO - Using env: {'DISPLAY': ':0', 15:49:24 INFO - 'HOME': '/home/cltbld', 15:49:24 INFO - 'LANG': 'en_US.UTF-8', 15:49:24 INFO - 'LANGUAGE': 'en_US:en', 15:49:24 INFO - 'LOGNAME': 'cltbld', 15:49:24 INFO - 'MAIL': '/var/mail/cltbld', 15:49:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:24 INFO - 'MOZ_NO_REMOTE': '1', 15:49:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:24 INFO - 'NO_EM_RESTART': '1', 15:49:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:24 INFO - 'PWD': '/builds/slave/test', 15:49:24 INFO - 'SHELL': '/bin/bash', 15:49:24 INFO - 'SHLVL': '1', 15:49:24 INFO - 'TERM': 'linux', 15:49:24 INFO - 'TMOUT': '86400', 15:49:24 INFO - 'USER': 'cltbld', 15:49:24 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1471906145.370864-1644060607', 15:49:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:24 INFO - '_': '/tools/buildbot/bin/python'} 15:49:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:24 INFO - Downloading/unpacking psutil>=3.1.1 15:49:24 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 15:49:24 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 15:49:24 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 15:49:24 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 15:49:24 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 15:49:24 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 15:49:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:49:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:49:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:49:26 INFO - Installing collected packages: psutil 15:49:26 INFO - Running setup.py install for psutil 15:49:26 INFO - building 'psutil._psutil_linux' extension 15:49:26 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 15:49:27 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 15:49:27 INFO - building 'psutil._psutil_posix' extension 15:49:27 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 15:49:27 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 15:49:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:49:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:49:27 INFO - Successfully installed psutil 15:49:27 INFO - Cleaning up... 15:49:27 INFO - Return code: 0 15:49:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:49:27 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')]} 15:49:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:27 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')]} 15:49:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:27 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 0x7f39d8b14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21e0230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21da090>, '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 0x21dd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21dde40>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1471906145.370864-1644060607', '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 15:49:27 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 15:49:27 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 15:49:27 INFO - Using env: {'DISPLAY': ':0', 15:49:27 INFO - 'HOME': '/home/cltbld', 15:49:27 INFO - 'LANG': 'en_US.UTF-8', 15:49:27 INFO - 'LANGUAGE': 'en_US:en', 15:49:27 INFO - 'LOGNAME': 'cltbld', 15:49:27 INFO - 'MAIL': '/var/mail/cltbld', 15:49:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:27 INFO - 'MOZ_NO_REMOTE': '1', 15:49:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:27 INFO - 'NO_EM_RESTART': '1', 15:49:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:27 INFO - 'PWD': '/builds/slave/test', 15:49:27 INFO - 'SHELL': '/bin/bash', 15:49:27 INFO - 'SHLVL': '1', 15:49:27 INFO - 'TERM': 'linux', 15:49:27 INFO - 'TMOUT': '86400', 15:49:27 INFO - 'USER': 'cltbld', 15:49:27 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1471906145.370864-1644060607', 15:49:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:27 INFO - '_': '/tools/buildbot/bin/python'} 15:49:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:49:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:49:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:49:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:49:29 INFO - Installing collected packages: mozsystemmonitor 15:49:29 INFO - Running setup.py install for mozsystemmonitor 15:49:29 INFO - Successfully installed mozsystemmonitor 15:49:29 INFO - Cleaning up... 15:49:29 INFO - Return code: 0 15:49:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:49: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')]} 15:49:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49: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')]} 15:49:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f39d8b14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21e0230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21da090>, '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 0x21dd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21dde40>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1471906145.370864-1644060607', '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 15:49: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==2.5.1'] in /builds/slave/test/build 15:49: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==2.5.1 15:49:29 INFO - Using env: {'DISPLAY': ':0', 15:49:29 INFO - 'HOME': '/home/cltbld', 15:49:29 INFO - 'LANG': 'en_US.UTF-8', 15:49:29 INFO - 'LANGUAGE': 'en_US:en', 15:49:29 INFO - 'LOGNAME': 'cltbld', 15:49:29 INFO - 'MAIL': '/var/mail/cltbld', 15:49:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:29 INFO - 'MOZ_NO_REMOTE': '1', 15:49:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:29 INFO - 'NO_EM_RESTART': '1', 15:49:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:29 INFO - 'PWD': '/builds/slave/test', 15:49:29 INFO - 'SHELL': '/bin/bash', 15:49:29 INFO - 'SHLVL': '1', 15:49:29 INFO - 'TERM': 'linux', 15:49:29 INFO - 'TMOUT': '86400', 15:49:29 INFO - 'USER': 'cltbld', 15:49:29 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1471906145.370864-1644060607', 15:49:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:29 INFO - '_': '/tools/buildbot/bin/python'} 15:49:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:29 INFO - Downloading/unpacking jsonschema==2.5.1 15:49:29 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 15:49:29 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 15:49:29 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 15:49:29 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 15:49:29 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 15:49:29 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 15:49:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:49:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:49:31 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 15:49:31 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 15:49:31 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 15:49:31 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 15:49:31 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 15:49:31 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 15:49:32 INFO - Downloading functools32-3.2.3-2.tar.gz 15:49:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:49:32 INFO - warning: no files found matching '*.txt' 15:49:32 INFO - no previously-included directories found matching 'build' 15:49:32 INFO - no previously-included directories found matching 'dist' 15:49:32 INFO - no previously-included directories found matching '.git*' 15:49:32 INFO - Installing collected packages: jsonschema, functools32 15:49:32 INFO - Running setup.py install for functools32 15:49:32 INFO - warning: no files found matching '*.txt' 15:49:32 INFO - no previously-included directories found matching 'build' 15:49:32 INFO - no previously-included directories found matching 'dist' 15:49:32 INFO - no previously-included directories found matching '.git*' 15:49:32 INFO - Successfully installed jsonschema functools32 15:49:32 INFO - Cleaning up... 15:49:32 INFO - Return code: 0 15:49:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:49:32 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')]} 15:49:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:32 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')]} 15:49:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:32 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 0x7f39d8b14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21e0230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21da090>, '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 0x21dd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21dde40>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1471906145.370864-1644060607', '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 15:49:32 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 15:49:32 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 15:49:32 INFO - Using env: {'DISPLAY': ':0', 15:49:32 INFO - 'HOME': '/home/cltbld', 15:49:32 INFO - 'LANG': 'en_US.UTF-8', 15:49:32 INFO - 'LANGUAGE': 'en_US:en', 15:49:32 INFO - 'LOGNAME': 'cltbld', 15:49:32 INFO - 'MAIL': '/var/mail/cltbld', 15:49:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:32 INFO - 'MOZ_NO_REMOTE': '1', 15:49:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:32 INFO - 'NO_EM_RESTART': '1', 15:49:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:32 INFO - 'PWD': '/builds/slave/test', 15:49:32 INFO - 'SHELL': '/bin/bash', 15:49:32 INFO - 'SHLVL': '1', 15:49:32 INFO - 'TERM': 'linux', 15:49:32 INFO - 'TMOUT': '86400', 15:49:32 INFO - 'USER': 'cltbld', 15:49:32 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1471906145.370864-1644060607', 15:49:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:32 INFO - '_': '/tools/buildbot/bin/python'} 15:49:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:49:32 INFO - Cleaning up... 15:49:32 INFO - Return code: 0 15:49:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:49:32 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')]} 15:49:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:32 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')]} 15:49:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:32 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 0x7f39d8b14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21e0230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21da090>, '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 0x21dd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21dde40>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1471906145.370864-1644060607', '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 15:49:32 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 15:49:32 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 15:49:32 INFO - Using env: {'DISPLAY': ':0', 15:49:32 INFO - 'HOME': '/home/cltbld', 15:49:32 INFO - 'LANG': 'en_US.UTF-8', 15:49:32 INFO - 'LANGUAGE': 'en_US:en', 15:49:32 INFO - 'LOGNAME': 'cltbld', 15:49:32 INFO - 'MAIL': '/var/mail/cltbld', 15:49:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:32 INFO - 'MOZ_NO_REMOTE': '1', 15:49:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:32 INFO - 'NO_EM_RESTART': '1', 15:49:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:32 INFO - 'PWD': '/builds/slave/test', 15:49:32 INFO - 'SHELL': '/bin/bash', 15:49:32 INFO - 'SHLVL': '1', 15:49:32 INFO - 'TERM': 'linux', 15:49:32 INFO - 'TMOUT': '86400', 15:49:32 INFO - 'USER': 'cltbld', 15:49:32 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1471906145.370864-1644060607', 15:49:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:32 INFO - '_': '/tools/buildbot/bin/python'} 15:49:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:32 INFO - Downloading/unpacking blobuploader==1.2.4 15:49:32 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 15:49:32 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 15:49:32 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 15:49:32 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 15:49:32 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 15:49:32 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 15:49:34 INFO - Downloading blobuploader-1.2.4.tar.gz 15:49:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:49:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:49:34 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 15:49:34 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 15:49:34 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 15:49:34 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 15:49:34 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 15:49:34 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 15:49:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:49:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:49:35 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 15:49:35 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 15:49:35 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 15:49:35 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 15:49:35 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 15:49:35 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 15:49:35 INFO - Downloading docopt-0.6.1.tar.gz 15:49:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:49:35 INFO - Installing collected packages: blobuploader, requests, docopt 15:49:35 INFO - Running setup.py install for blobuploader 15:49:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:49:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:49:35 INFO - Running setup.py install for requests 15:49:35 INFO - Running setup.py install for docopt 15:49:35 INFO - Successfully installed blobuploader requests docopt 15:49:35 INFO - Cleaning up... 15:49:36 INFO - Return code: 0 15:49:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:49:36 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')]} 15:49:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:36 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')]} 15:49:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:36 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 0x7f39d8b14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21e0230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21da090>, '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 0x21dd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21dde40>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1471906145.370864-1644060607', '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 15:49:36 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 15:49:36 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 15:49:36 INFO - Using env: {'DISPLAY': ':0', 15:49:36 INFO - 'HOME': '/home/cltbld', 15:49:36 INFO - 'LANG': 'en_US.UTF-8', 15:49:36 INFO - 'LANGUAGE': 'en_US:en', 15:49:36 INFO - 'LOGNAME': 'cltbld', 15:49:36 INFO - 'MAIL': '/var/mail/cltbld', 15:49:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:36 INFO - 'MOZ_NO_REMOTE': '1', 15:49:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:36 INFO - 'NO_EM_RESTART': '1', 15:49:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:36 INFO - 'PWD': '/builds/slave/test', 15:49:36 INFO - 'SHELL': '/bin/bash', 15:49:36 INFO - 'SHLVL': '1', 15:49:36 INFO - 'TERM': 'linux', 15:49:36 INFO - 'TMOUT': '86400', 15:49:36 INFO - 'USER': 'cltbld', 15:49:36 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1471906145.370864-1644060607', 15:49:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:36 INFO - '_': '/tools/buildbot/bin/python'} 15:49:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:49:36 INFO - Running setup.py (path:/tmp/pip-spIUqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:49:36 INFO - Running setup.py (path:/tmp/pip-UQi_dc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:49:36 INFO - Running setup.py (path:/tmp/pip-_wnIuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:49:36 INFO - Running setup.py (path:/tmp/pip-ROQptA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:49:36 INFO - Running setup.py (path:/tmp/pip-zCSd_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:49:36 INFO - Running setup.py (path:/tmp/pip-f6CB3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:49:36 INFO - Running setup.py (path:/tmp/pip-gUpfba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:49:36 INFO - Running setup.py (path:/tmp/pip-v5gAdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:49:36 INFO - Running setup.py (path:/tmp/pip-166Uke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:49:36 INFO - Running setup.py (path:/tmp/pip-OSIQI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:49:36 INFO - Running setup.py (path:/tmp/pip-1oNu6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:49:37 INFO - Running setup.py (path:/tmp/pip-rSqI7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:49:37 INFO - Running setup.py (path:/tmp/pip-uCal9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:49:37 INFO - Running setup.py (path:/tmp/pip-x12Iwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:49:37 INFO - Running setup.py (path:/tmp/pip-8UC3vE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:49:37 INFO - Running setup.py (path:/tmp/pip-QqRItn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:49:37 INFO - Running setup.py (path:/tmp/pip-6d6Z2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:49:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:49:37 INFO - Running setup.py install for manifestparser 15:49:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:49:37 INFO - Running setup.py install for mozcrash 15:49:37 INFO - Running setup.py install for mozdebug 15:49:37 INFO - Running setup.py install for mozdevice 15:49:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:49:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:49:37 INFO - Running setup.py install for mozfile 15:49:37 INFO - Running setup.py install for mozhttpd 15:49:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:49:38 INFO - Running setup.py install for mozinfo 15:49:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:49:38 INFO - Running setup.py install for mozInstall 15:49:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:49:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:49:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:49:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:49:38 INFO - Running setup.py install for mozleak 15:49:38 INFO - Running setup.py install for mozlog 15:49:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:49:38 INFO - Running setup.py install for moznetwork 15:49:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:49:38 INFO - Running setup.py install for mozprocess 15:49:38 INFO - Running setup.py install for mozprofile 15:49:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:49:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:49:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:49:38 INFO - Running setup.py install for mozrunner 15:49:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:49:38 INFO - Running setup.py install for mozscreenshot 15:49:39 INFO - Running setup.py install for moztest 15:49:39 INFO - Running setup.py install for mozversion 15:49:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:49:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:49:39 INFO - Cleaning up... 15:49:39 INFO - Return code: 0 15:49:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:49:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:39 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 0x7f39d8b14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21e0230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21da090>, '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 0x21dd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21dde40>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1471906145.370864-1644060607', '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 15:49:39 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 15:49:39 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 15:49:39 INFO - Using env: {'DISPLAY': ':0', 15:49:39 INFO - 'HOME': '/home/cltbld', 15:49:39 INFO - 'LANG': 'en_US.UTF-8', 15:49:39 INFO - 'LANGUAGE': 'en_US:en', 15:49:39 INFO - 'LOGNAME': 'cltbld', 15:49:39 INFO - 'MAIL': '/var/mail/cltbld', 15:49:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:39 INFO - 'MOZ_NO_REMOTE': '1', 15:49:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:39 INFO - 'NO_EM_RESTART': '1', 15:49:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:39 INFO - 'PWD': '/builds/slave/test', 15:49:39 INFO - 'SHELL': '/bin/bash', 15:49:39 INFO - 'SHLVL': '1', 15:49:39 INFO - 'TERM': 'linux', 15:49:39 INFO - 'TMOUT': '86400', 15:49:39 INFO - 'USER': 'cltbld', 15:49:39 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1471906145.370864-1644060607', 15:49:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:39 INFO - '_': '/tools/buildbot/bin/python'} 15:49:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:49:39 INFO - Running setup.py (path:/tmp/pip-ASfaUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:49:39 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)) 15:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:49:39 INFO - Running setup.py (path:/tmp/pip-Snsgjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:49:39 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)) 15:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:49:39 INFO - Running setup.py (path:/tmp/pip-iYsezL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:49:39 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)) 15:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:49:39 INFO - Running setup.py (path:/tmp/pip-Idk0Oy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:49:39 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)) 15:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:49:39 INFO - Running setup.py (path:/tmp/pip-f5iVqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:49:39 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)) 15:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:49:39 INFO - Running setup.py (path:/tmp/pip-1US3BA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:49:39 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)) 15:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:49:39 INFO - Running setup.py (path:/tmp/pip-_YjEbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:49:39 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)) 15:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:49:39 INFO - Running setup.py (path:/tmp/pip-bfwhmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:49:40 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)) 15:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:49:40 INFO - Running setup.py (path:/tmp/pip-0gnVgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:49:40 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)) 15:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:49:40 INFO - Running setup.py (path:/tmp/pip-l_og6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:49:40 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)) 15:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:49:40 INFO - Running setup.py (path:/tmp/pip-A13D1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:49:40 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)) 15:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:49:40 INFO - Running setup.py (path:/tmp/pip-HPLwSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:49:40 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)) 15:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:49:40 INFO - Running setup.py (path:/tmp/pip-P15VQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:49:40 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)) 15:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:49:40 INFO - Running setup.py (path:/tmp/pip-lauseI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:49:40 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)) 15:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:49:40 INFO - Running setup.py (path:/tmp/pip-pLLQ3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:49:40 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)) 15:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:49:40 INFO - Running setup.py (path:/tmp/pip-vqyHok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:49:40 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)) 15:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:49:40 INFO - Running setup.py (path:/tmp/pip-rmpvEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:49:40 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)) 15:49:40 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)) 15:49:40 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)) 15:49:40 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)) 15:49:40 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)) 15:49:40 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)) 15:49:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:49:40 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 15:49:40 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 15:49:40 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 15:49:40 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 15:49:40 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 15:49:40 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 15:49:43 INFO - Downloading blessings-1.6.tar.gz 15:49:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:49:43 INFO - Installing collected packages: blessings 15:49:43 INFO - Running setup.py install for blessings 15:49:43 INFO - Successfully installed blessings 15:49:43 INFO - Cleaning up... 15:49:43 INFO - Return code: 0 15:49:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:49:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:49:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:49:44 INFO - Reading from file tmpfile_stdout 15:49:44 INFO - Current package versions: 15:49:44 INFO - argparse == 1.2.1 15:49:44 INFO - blessings == 1.6 15:49:44 INFO - blobuploader == 1.2.4 15:49:44 INFO - docopt == 0.6.1 15:49:44 INFO - functools32 == 3.2.3-2 15:49:44 INFO - jsonschema == 2.5.1 15:49:44 INFO - manifestparser == 1.1 15:49:44 INFO - mozInstall == 1.12 15:49:44 INFO - mozcrash == 0.17 15:49:44 INFO - mozdebug == 0.1 15:49:44 INFO - mozdevice == 0.48 15:49:44 INFO - mozfile == 1.2 15:49:44 INFO - mozhttpd == 0.7 15:49:44 INFO - mozinfo == 0.9 15:49:44 INFO - mozleak == 0.1 15:49:44 INFO - mozlog == 3.3 15:49:44 INFO - moznetwork == 0.27 15:49:44 INFO - mozprocess == 0.23 15:49:44 INFO - mozprofile == 0.28 15:49:44 INFO - mozrunner == 6.12 15:49:44 INFO - mozscreenshot == 0.1 15:49:44 INFO - mozsystemmonitor == 0.3 15:49:44 INFO - moztest == 0.7 15:49:44 INFO - mozversion == 1.4 15:49:44 INFO - psutil == 3.1.1 15:49:44 INFO - requests == 1.2.3 15:49:44 INFO - wsgiref == 0.1.2 15:49:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:49:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:44 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 0x7f39d8b14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21e0230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21da090>, '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 0x21dd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21dde40>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1471906145.370864-1644060607', '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 15:49:44 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 15:49:44 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 15:49:44 INFO - Using env: {'DISPLAY': ':0', 15:49:44 INFO - 'HOME': '/home/cltbld', 15:49:44 INFO - 'LANG': 'en_US.UTF-8', 15:49:44 INFO - 'LANGUAGE': 'en_US:en', 15:49:44 INFO - 'LOGNAME': 'cltbld', 15:49:44 INFO - 'MAIL': '/var/mail/cltbld', 15:49:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:44 INFO - 'MOZ_NO_REMOTE': '1', 15:49:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:44 INFO - 'NO_EM_RESTART': '1', 15:49:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:44 INFO - 'PWD': '/builds/slave/test', 15:49:44 INFO - 'SHELL': '/bin/bash', 15:49:44 INFO - 'SHLVL': '1', 15:49:44 INFO - 'TERM': 'linux', 15:49:44 INFO - 'TMOUT': '86400', 15:49:44 INFO - 'USER': 'cltbld', 15:49:44 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1471906145.370864-1644060607', 15:49:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:44 INFO - '_': '/tools/buildbot/bin/python'} 15:49:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:44 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)) 15:49:44 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)) 15:49:44 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)) 15:49:44 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)) 15:49:44 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)) 15:49:44 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)) 15:49:44 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)) 15:49:44 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)) 15:49:44 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)) 15:49:44 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)) 15:49:44 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)) 15:49:44 INFO - Cleaning up... 15:49:44 INFO - Return code: 0 15:49:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:49:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f39d8b14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21e0230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21da090>, '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 0x21dd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21dde40>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1471906145.370864-1644060607', '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 15:49:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:49:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:49:44 INFO - Using env: {'DISPLAY': ':0', 15:49:44 INFO - 'HOME': '/home/cltbld', 15:49:44 INFO - 'LANG': 'en_US.UTF-8', 15:49:44 INFO - 'LANGUAGE': 'en_US:en', 15:49:44 INFO - 'LOGNAME': 'cltbld', 15:49:44 INFO - 'MAIL': '/var/mail/cltbld', 15:49:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:44 INFO - 'MOZ_NO_REMOTE': '1', 15:49:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:44 INFO - 'NO_EM_RESTART': '1', 15:49:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:44 INFO - 'PWD': '/builds/slave/test', 15:49:44 INFO - 'SHELL': '/bin/bash', 15:49:44 INFO - 'SHLVL': '1', 15:49:44 INFO - 'TERM': 'linux', 15:49:44 INFO - 'TMOUT': '86400', 15:49:44 INFO - 'USER': 'cltbld', 15:49:44 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1471906145.370864-1644060607', 15:49:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:44 INFO - '_': '/tools/buildbot/bin/python'} 15:49:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:49:44 INFO - Cleaning up... 15:49:44 INFO - Return code: 0 15:49:44 INFO - Running post-action listener: _resource_record_post_action 15:49:44 INFO - Running post-action listener: _start_resource_monitoring 15:49:44 INFO - Starting resource monitoring. 15:49:44 INFO - [mozharness: 2016-08-22 22:49:44.546487Z] Finished create-virtualenv step (success) 15:49:44 INFO - [mozharness: 2016-08-22 22:49:44.547003Z] Running install step. 15:49:44 INFO - Running pre-action listener: _resource_record_pre_action 15:49:44 INFO - Running main action method: install 15:49:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:49:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:49:44 INFO - Reading from file tmpfile_stdout 15:49:44 INFO - Detecting whether we're running mozinstall >=1.0... 15:49:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:49:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:49:44 INFO - Reading from file tmpfile_stdout 15:49:44 INFO - Output received: 15:49:44 INFO - Usage: mozinstall [options] installer 15:49:44 INFO - Options: 15:49:44 INFO - -h, --help show this help message and exit 15:49:44 INFO - -d DEST, --destination=DEST 15:49:44 INFO - Directory to install application into. [default: 15:49:44 INFO - "/builds/slave/test"] 15:49:44 INFO - --app=APP Application being installed. [default: firefox] 15:49:44 INFO - mkdir: /builds/slave/test/build/application 15:49:44 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'] 15:49:44 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 15:50:00 INFO - Reading from file tmpfile_stdout 15:50:00 INFO - Output received: 15:50:00 INFO - /builds/slave/test/build/application/firefox/firefox 15:50:00 INFO - Running post-action listener: _resource_record_post_action 15:50:00 INFO - [mozharness: 2016-08-22 22:50:00.932068Z] Finished install step (success) 15:50:00 INFO - [mozharness: 2016-08-22 22:50:00.932314Z] Running run-tests step. 15:50:00 INFO - Running pre-action listener: _resource_record_pre_action 15:50:00 INFO - Running main action method: run_tests 15:50:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:50:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:50:00 INFO - Python 2.7.3 15:50:00 INFO - Return code: 0 15:50:00 INFO - grabbing minidump binary from tooltool 15:50:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:00 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 0x21da090>, '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 0x21dd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21dde40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:50:00 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 15:50:00 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 15:50:00 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 15:50:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:50:01 INFO - Return code: 0 15:50:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:50:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:50:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:50:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:50:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:50:01 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/T4J-7ohwSdGP-I9a6YvoMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 15:50:01 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/T4J-7ohwSdGP-I9a6YvoMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --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 15:50:01 INFO - Using env: {'DISPLAY': ':0', 15:50:01 INFO - 'HOME': '/home/cltbld', 15:50:01 INFO - 'LANG': 'en_US.UTF-8', 15:50:01 INFO - 'LANGUAGE': 'en_US:en', 15:50:01 INFO - 'LOGNAME': 'cltbld', 15:50:01 INFO - 'MAIL': '/var/mail/cltbld', 15:50:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:50:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:50:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:01 INFO - 'MOZ_NO_REMOTE': '1', 15:50:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:50:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:01 INFO - 'NO_EM_RESTART': '1', 15:50:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:01 INFO - 'PWD': '/builds/slave/test', 15:50:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:50:01 INFO - 'SHELL': '/bin/bash', 15:50:01 INFO - 'SHLVL': '1', 15:50:01 INFO - 'TERM': 'linux', 15:50:01 INFO - 'TMOUT': '86400', 15:50:01 INFO - 'USER': 'cltbld', 15:50:01 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1471906145.370864-1644060607', 15:50:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:01 INFO - '_': '/tools/buildbot/bin/python'} 15:50:01 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/T4J-7ohwSdGP-I9a6YvoMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 15:50:01 INFO - mozversion application_buildid: 20160822145214 15:50:01 INFO - mozversion application_changeset: 3e537d8eb88c440fd0b7aa88deec56aa688715b0 15:50:01 INFO - mozversion application_display_name: Nightly 15:50:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:50:01 INFO - mozversion application_name: Firefox 15:50:01 INFO - mozversion application_remotingname: firefox 15:50:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:50:01 INFO - mozversion application_vendor: Mozilla 15:50:01 INFO - mozversion application_version: 51.0a1 15:50:01 INFO - mozversion platform_buildid: 20160822145214 15:50:01 INFO - mozversion platform_changeset: 3e537d8eb88c440fd0b7aa88deec56aa688715b0 15:50:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:50:01 INFO - mozversion platform_version: 51.0a1 15:50:01 INFO - using testdate: 1471906201 15:50:01 INFO - actual date: 1471906201 15:50:01 INFO - starting webserver on 'localhost:35586' 15:50:01 INFO - SUITE-START | Running 2 tests 15:50:01 INFO - TEST-START | dromaeo_css 15:50:01 INFO - operating with platform_type : linux_ 15:50:01 INFO - Initialising browser for dromaeo_css test... 15:50:01 INFO - TEST-INFO | started process 14516 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuwWNuU/profile http://localhost:35586/getInfo.html) 15:50:05 INFO - PROCESS | 14516 | __metrics Screen width/height:1600/1200 15:50:05 INFO - PROCESS | 14516 | colorDepth:24 15:50:05 INFO - PROCESS | 14516 | Browser inner width/height: 1024/697 15:50:05 INFO - PROCESS | 14516 | __metrics 15:50:06 INFO - PROCESS | 14516 | 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" 15:50:06 INFO - PROCESS | 14516 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:50:07 INFO - TEST-INFO | 14516: exit 0 15:50:07 INFO - Browser initialized. 15:50:07 INFO - Running cycle 1/1 for dromaeo_css test... 15:50:07 INFO - TEST-INFO | started process 14599 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuwWNuU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:50:19 INFO - PROCESS | 14599 | RSS: Main: 175005696 15:50:19 INFO - PROCESS | 14599 | 15:51:11 INFO - PROCESS | 14599 | 1471906271408 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] 15:53:23 INFO - PROCESS | 14599 | Cycle 1(1): loaded http://localhost:35586/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35586/tests/dromaeo/cssquery-ext.html) 15:53:24 INFO - PROCESS | 14599 | RSS: Main: 259207168 15:53:24 INFO - PROCESS | 14599 | 15:56:27 INFO - PROCESS | 14599 | Cycle 1(1): loaded http://localhost:35586/tests/dromaeo/cssquery-ext.html (next: http://localhost:35586/tests/dromaeo/cssquery-jquery.html) 15:56:27 INFO - PROCESS | 14599 | RSS: Main: 272769024 15:56:27 INFO - PROCESS | 14599 | 15:59:29 INFO - PROCESS | 14599 | Cycle 1(1): loaded http://localhost:35586/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35586/tests/dromaeo/cssquery-mootools.html) 15:59:30 INFO - PROCESS | 14599 | RSS: Main: 219209728 15:59:30 INFO - PROCESS | 14599 | 16:02:33 INFO - PROCESS | 14599 | Cycle 1(1): loaded http://localhost:35586/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35586/tests/dromaeo/cssquery-prototype.html) 16:02:33 INFO - PROCESS | 14599 | RSS: Main: 217489408 16:02:33 INFO - PROCESS | 14599 | 16:05:36 INFO - PROCESS | 14599 | Cycle 1(1): loaded http://localhost:35586/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35586/tests/dromaeo/cssquery-yui.html) 16:05:37 INFO - PROCESS | 14599 | RSS: Main: 219570176 16:05:37 INFO - PROCESS | 14599 | 16:08:40 INFO - PROCESS | 14599 | Cycle 1(1): loaded http://localhost:35586/tests/dromaeo/cssquery-yui.html (next: http://localhost:35586/tests/dromaeo/cssquery-dojo.html) 16:08:40 INFO - PROCESS | 14599 | RSS: Main: 311754752 16:08:40 INFO - PROCESS | 14599 | 16:08:40 INFO - PROCESS | 14599 | __start_tp_report 16:08:40 INFO - PROCESS | 14599 | _x_x_mozilla_page_load 16:08:40 INFO - PROCESS | 14599 | _x_x_mozilla_page_load_details 16:08:40 INFO - PROCESS | 14599 | |i|pagename|runs| 16:08:40 INFO - PROCESS | 14599 | |0;dojo.html;2547.898084076636;2600.7139214686385;2604.986975065124;2609;2622.1215892675955;4633.027064316498;4645.047765208133;4670.322803193535;4755.3104799804005;4763.1188230177395;4622.676412651116;4699.318598803172;4727.409073865775;4758.262469317261;4774.594159496447;4153.397757325186;4379.956200437987;4403.163398954204;4416.889577760549;4438.644908407319;4408.603225709701;4418.469783625969;4418.5581441855875;4450.043240703249;4465.598096171344;4264.189803937273;4276.3157894737005;4306.0957198987935;4325.178216138924;4383.408239887606;4348.130373925228;4351.912961740779;4353.455818022747;4356.738595684269;4363.454568178978;4324.913501729948;4332.220200363933;4344.847930322424;4353.891152721176;4363.040131171138;4585.862424127282;4651.511591282901;4727.172744769686;4767.570918617306;4768.904621907543;5068.543831055223;5106.897862042739;5110.795568177268;5111.08000559899;5114.207297868837;5101.591872650179;5106.872328191787;5117.82087626935;5122.871928201787;5124.103281925648;4610.2854057621125;4712.222483290218;4753.04939012199;4782.13921494131;4790.089882922233;5223.660462069954;5246.291750613618;5255.237990491358;5258.5267325940085;5261.473852614785;5031.597472202215;5036.29491871131;5039.647224694236;5040.168372218543;5044.899102018013;4881.633877459205;4947.628927830355;4959.2809042688605;5087.796488140507;5093.414257360377;5016.824411145592;5021.07110184617;5034.270030845507;5037.974810125926;5040.042391945519;5002.399712034579;5014.749262536859;5015.27278544609;5015.398152221756;5023.296738456619;4084.0606660468256;4103.528094269138;4110.095778928631;4268.40242366069;4273.615374616299;3663.175785448253;3671.908202294964;3689.1146124929824;3702.1485058436174;3746.550413950289;4376.978115109404;4381.583749543788;4384.254676704968;4391.012022294958;4393.275109606943;5132.358455193101;5139.023585518814;5158.380994280636;5158.664686795346;5161.845144645667;4214.367844823301;4220.704550681423;4265.232258193493;4381.737095774264;4390.53899340571;4498.235299999008;4513.50351461339;4514.210013247734;4521.570450807168;4525.683202175816;4721.976390118096;4728.692634978715;4729.9054018920115;4730.2195137803255;4730.385049943554;4987.975060124676;5034.84895453137;5037.244413338029;5038.773255203451;5085.313482679939;4819.927701084556;4833.903321933612;4833.95166048335;4840.443349014768;4840.782164802522;5076.492350764894;5078.415982162099;5079.746012699276;5080.060188865072;5083.72039537829;4923.852284431473;4977.552020318189;4989.451160372429;5108.463611320906;5113.437521872516;4899.779509921991;4916.115099282163;4930.235813448921;4942.6293028023765;4943.802247910044;4892.633052521004;4912.508749125202;4927.01459708067;4929.6549241554185;4940.604751619933;4677.3451716759;4833.154198015403;4864.246041863516;4883.291922671264;4908.730019848943;4981.227909674007;4990.50094990498;4995.700257984533;4999.475055119306;5033.672811267256;4866;4894.632902532253;4916.115099282163;4921.138800709933;4921.434035086011 16:08:40 INFO - PROCESS | 14599 | |1;ext.html;562.800205926896;571.0149991265068;571.959962802604;575.3239943066898;576.8500189950613;28844.423111537784;29414.411711765777;31689.841550792215;31758.04725858225;37974.62025379745;36534.634653653455;40924.38613420801;41028.58971410285;41042.179156416925;41057.178856422855;7557.24427557244;7702.845943081135;7704.499207551519;7707.383409327268;7707.845843083135;7610.35311998478;7683.34691551216;7689.461737678364;7693.538387696728;7709.537427754324;7671.884921726179;7713.807154821118;7717.768466946;7718.266764657348;7722.691092356327;7622.085349758009;7658.617069146549;7697.076350837935;7703.22967703228;7704.576248306341;7451.403887688972;7508.2867127622785;7513.248675132443;7670.424718146106;7678.155402905676;37128;37579.060523486856;37828.43257351142;37892.43161352582;37933;2624.238970698495;2678.1965410377;2700.9189724308303;2711.0917842522776;2722.6324446199706;28558;28829.279268018257;28863.855680721463;28931;29722.70277297221;3391.8473668684724;3432.828358582061;3520.507129001942;3559.359315323241;3583.175869549992;251634;252026;252516.73741631358;254371;256330;50827.74586127046;51116.23325650118;51137.744311278206;51179;51214;45727.77136114298;47964.5203547967;51338.74330628398;54310.18534721982;54621;12877.227366358049;13094.410751516014;13172.407241674147;13365.131266467648;13422.261775602436;10021;10103.494825258707;10106.797864042677;10112.342697724624;10126.949365253127;13439.596812095653;15104.924475377773;15613.453529126426;15667.686646267011;15696.686066278611;5970.4775282302735;6107.305080426367;6215.627062376181;6273.341299163613;6305.5901366411035;742.254034695128;795.9243871832167;850.9234168924703;864.4337958637103;887.5256635416898;26053.60919586208;27766.583501247496;28046.43907121846;28405.289867753472;28457.715422845922;888.1651247827022;925.833349997007;947.3131979314942;988.3526290279734;1003.0771690045176;14695.632609184855;14873.851261487463;15025.624359391102;15056.171910544806;15195;357589;360434;360868;361062;361728;48670;48841.26738098932;48928.75535622299;49009.75495122502;49026.26460603094;994.3785134291068;1021.3259248895694;1025.1849779425374;1053.5733028123623;1159.5014143918197;25472;26826.59760103561;27507.862460687567;27628.470540053757;28089.859550702935;42182.36726449167;42621.78689106535;42623;42666.14667706691;42739.78630106829;318023;321453.17820232245;321678;323298;324192;30268.394632107676;36084.63915360813;37760.62239377571;39588.406173906835;39591.40612890751;40504.59495405008;40514.1897162061;40919.1816163681;41878.37182442205;41985.37021944612;34779.478307825906;35039;35248.47127293144;35418.64581354154;35606;33182.19311620505;35165;35490.46764298486;35496.82251588725;35766.46350304696;34816;34867.65132348644;35069.123271917386;35658.82170589131;35719;29399.26501837471;31725;31829.6817031836;32184.678153218167;32427;24175.978002749656;24703.752962470866;25150.748492514842;25235.369115772253;25403.20169055638 16:08:40 INFO - PROCESS | 14599 | |2;jquery.html;354.4859953068052;361.81185783392647;361.9113317237277;373.3932359915138;376.3770959062752;15866.920665396672;16898.32406703732;16982.32070717173;17149.657006859856;17169.484915452525;13920.930395348034;14264.643383915381;14398.784018239734;15089.92455037726;15462.690746185097;4555.180067587841;4898.902021959559;4931.791711030803;4931.876703082434;4937.6790508617005;3605.242898991215;3791.981040094796;4894.1679914414635;5675.659460432387;5940.970295148518;6012.789552365668;6013.398660133996;6025.939740602582;6026.789062382817;6027.186329845481;5815.214945982301;5989.490893274077;6028.849278768022;6031.45716885478;6038.154658347835;4480.955190448087;5248.475152484759;5278.261043453919;5280.894382112375;5283.577313814885;10275.177985761122;10551.20865935058;10556.366618002867;10556.947215263952;10560;1741.5907261793468;1781.376518218626;2106.620808254529;2156.590247852903;2269.5914735347633;8562.14378562145;8642.65429382824;8745.650173993032;8843.646254149826;9026.368154229142;1637.287779815784;1656.6686662667394;1664.6920319740766;1674.3888480704577;1750.8424241818298;67104.32895671029;67404.6629766848;68296;69872;70929.64535177343;9902.752431189278;9974.650887218913;9983.500824958723;10058.547365368577;10222.437765922945;13727;13773.380197890918;13774.793378099337;13779.586612401645;13790.862091378958;6878.415334696507;6989.126359205099;7031.29687031303;7116.395106415909;7178.928210717931;6439.130717353098;6440.323766004596;6637.303083176197;6664.200295964515;6725.226598941086;4182.121754431542;4261.97869010653;4263.232618128704;4366.759828209415;4382.649388048949;1644.629958259406;1663.3512929957326;1689.923953422099;1751.4045224623435;1774.9112544372729;794.4557977785236;811.679386642273;813.2233716800441;873.9169778870997;914.0996118822954;15770.842291577166;16299.755503667455;16375.181240937905;16478.34086636521;17129.914350428167;786.7364432915037;792.3423558446476;824.1511243419287;829.9377546683902;866.27233124176;8758.666964884762;8914;9139.360244782802;9378.671746488977;9455;371766;374534;381202;398848;399457;76934.61532692413;78374.608126959;79683.60158199172;79785;80673.57979260631;807.7576726981882;851.5316575883239;872.023333866074;874.5277550122989;874.9475031498131;14239.50161744334;14282.714345713235;14475.203863787592;14656.633584160481;15195.620109497351;36281;37224;37269.25461490701;38549.4217586742;38988.61011389963;51046.74476627593;51562.74218628883;51740;51775.74112129415;52152.7392363051;7182.425405967615;7227.8554428912175;7254.854902901807;7321.3776828968;7391.186969433251;9581.952090239784;10893.782124357627;10985.890141098806;11031.779364412827;11805.76388472243;9451.858222126537;9598.32811703174;10119.494025298558;10175.236857235588;10309.278350515691;10013.849792252977;10082.495875206358;10237.129843963048;10330.845037324296;10467.947660261954;9875.308728388944;10065.396076235156;10179.694609161737;10255.384676919408;10724.571017159225;7159.534630249017;7296.562206267641;7428.73999410018;7455.627218639155;7525.548467091992;8685.739427817176;9950.601975921172;10272.486375681037;10664.786704266027;10742.3017503862 16:08:40 INFO - PROCESS | 14599 | |3;mootools.html;1235.8455193100863;1331.966700832479;1384.0173476831449;1411.46364381535;1677.605762645778;6644;7468.738594149206;7724.652390642421;7732.690692372298;7974.441789074767;7729.033870766154;7750.3799696024325;7837.568933708644;7851.60741962901;7851.685932562705;2151.7848215178474;2180.7056047433553;2182.792634699701;2184.814290785277;2207.47020715028;2090.278853795438;2126.5215326551556;2150.5483848391777;2150.7526634437004;2156.2992027591017;2154.515234072337;2180.4439867833757;2186.3768825884626;2186.912523499066;2198.9780102199015;2129.0419311309897;2132.1045161032403;2133.4453042208984;2134.274346722106;2135.6049130910833;2058.1870161286356;2118.2480219522004;2118.9788102118937;2122.9150833966623;2134.7651758306574;7752.612369381508;7755.689772409097;7857.764267071997;7866.370690344758;7885.093214280317;4390.824367025347;4508.2561377372695;4519.615832654195;4521.412216411845;4531.3203019547;2812.9718702812916;2938.32418543734;2970.7177818107243;2973.702629737009;2984.970150298491;908.4957848394139;916.4272329793879;924.3806649544754;932.1936524905975;934.6074648647516;10668.679939601747;10762.192835537366;10769.084627806646;10771.78456430867;10783.5686572537;3912.5304963404574;3924.0778417071965;4056.51321841375;4059.330210515232;4066.369712694537;8481.957590212009;8498.74503764888;8538.829223415496;8540.23137917578;8543.487390756574;4377.124575084996;4377.934330985037;4379.299312110047;4380.211561918885;4384.473863136444;3615.891523254307;3989.1822176453757;4075.5109386873764;4093.4064560639135;4133.545310015896;3323.667633236657;3371.780834245766;3454.671806178409;3481.599616044137;3487.163080860575;1011.9696409107738;1027.0499787696351;1027.712240572641;1034.896510348959;1061.2253055269696;591.1369400674977;741.6959046790897;755.3881356101575;762.9961850190714;768.0744702633314;5123.257127716534;5172.8965420691375;5208.744534665834;5208.791648334024;5333.973330133324;830.4187069051688;886.7029545102334;923.5843870258276;924.3344791749929;932.8292992294762;3322.7674062815854;3408.812515311632;3445.6554344565843;3526.9118272043406;3608.963910360915;9547.570359333708;9639.421634701941;9739.707808765606;9740.172085372822;9773.12041916231;9668.661596844076;9671.323007389416;9672.95163524178;9677.274204434554;9681.031896810262;7097.361237488651;7332.0834895638045;7390.7413240536325;7393.371563417169;7396.815079622945;4911.3369695090705;4941.407031156285;5010.647125276228;5058.898822023465;5080.796768129233;8506.659733610833;8674.566271686517;8897.2882169425;8957.955210223907;8985.326100542616;8949.418287811272;9066.320025998208;9113.726588202364;9114.908850911672;9119.270458363448;5353.197020446964;5854.765809367577;5886.529077673861;5995.370486098896;6000.039993601003;7292.234315396807;7455.925440745523;7461.365783908212;7489.325960663567;7503.699852005859;6530.412262896362;6533.509986750918;6585.6377899216;6669.7665581704405;6799.626020568916;6370.331115232834;6529.771457998947;6582;6729.158855143107;6784.728610855511;5831.70841457917;5923.111533269872;5932.8813423732145;5939.227900373096;5941.019731744386;4474.731516109044;4508.233600288025;4551.704139230939;4567.109413664436;4642.907141857211;4292.720973136861;4294.677899157638;4366.410534577792;4439.334099885043;4472.776361181993 16:08:40 INFO - PROCESS | 14599 | |4;prototype.html;291.3226747811339;296.120522049513;303.4446962059431;305.3328477277151;305.81803826723103;4807.254875494304;4808.495108013661;4816.903661926764;4824.324594556765;4846.733429661367;4693.929591056137;4742.549457801503;4761;4768.1894078006735;4789.401324834395;3566.6968307693814;3668.633136686337;3695.833687484056;3708.627807711137;3770.830312635924;3723.869664561741;3727.813609319523;3756.2863056019405;3769;3782.451544526042;3692;3698.630136986293;3706.240220754739;3710.8330125144435;3714.4213709173628;3513.7716048456896;3580.516630254934;3677.2461645362637;3680.411134218539;3729.601399475197;3245.8863939761995;3247.236899328656;3249.496328069153;3255.446574082388;3258.169166862435;4647.883802904955;4649.697769644962;4654.697444666086;4659.301104834268;4663.417072865892;4138.503379594468;4260.4248426462655;4265.3815196796295;4274.059706864485;4294.849680261207;4914.950850491485;4934.445649620394;4937.382827146606;4937.827176048857;4938.950610493921;3606.5672119345586;3618.3848745713294;3622.8188590570367;3623.981880090609;3636.8727094551564;5156.303898973665;5176;5178.14560597501;5211.400688920747;5255.343082114736;3575.481555174485;3702.111922919277;3702.777833329955;3713.20166164276;3731.626837316301;3719.8326075326677;3727.0682329417646;3727.7763334200035;3733.4959780429294;3734.141147536082;4223.788810559459;4237.978810105929;4242.278812601865;4255.127698821734;4261.637760790368;4715.363425937455;4937.23472861707;4947.233178857283;4966.279889416014;4987.950120498748;1238.9840330928553;1258.8111783232405;1261.88634037986;1267.4359909840032;1268.8413948256468;794.2256300107349;795.2047952047952;805.589149533742;824.9133840946735;826.6032304493876;4165.645920096765;4383.561643835591;4387.648988080946;4413.867583972486;4422.557744225552;5132.07471741104;5143.459936706667;5144.276667316416;5186.611004174702;5188.844334669966;4367.10474352757;4368.301071828492;4369.929367305031;4383.846565370197;4398.934015989763;2593.572060610016;2690;2699.487097451478;2711.227300219428;2728.358835673615;4816.579109162805;4817.78319975602;4823.382463152636;4829.710217386968;4839;5067.974660126676;5200.635955483155;5216.426193118754;5241.711705856138;5302.469753024744;4736.668433209642;4802.447718512416;4804.567588917014;4827.493113223061;4838.95161048385;5098.694078355311;5114.590832733298;5116.667416617908;5138.948610513847;5172.5603323716405;4885;4975.601082640237;5060.569851562658;5064.164412871834;5081.339425874613;4791.544803243686;4831.729087328949;4832.395950506187;4834.105690447279;4835.347228124158;3621.7464777465325;3632.400653892078;3632.654897784706;3660.926781464409;3666.7249956252854;4990.850274491771;5100.719460429564;5126.179811230185;5137.614678899172;5140.665856719302;4858.3441235432765;4908.852734417973;4937;4944.579710724484;4951.207806750903;4943.184374578298;4952.727599982036;4956.132676781477;4956.256561515802;5019.874503137451;4726.692764970266;4901.411830580353;4914.483979182134;4929.13740095489;4950.900981980412;4776.904461910673;4846.5460361892;4951;5004.724740139181;5006.623178625907;4877.341558889504;4887.853364399074;4926.48271931442;4945.2582112683385;4950.430700469492 16:08:40 INFO - PROCESS | 14599 | |5;yui.html;568.5565259097904;581.1602234770756;611.2298503885106;624.3194917539886;630.1241274628264;11344.886551134487;12292;12298.38508074596;12313.630591082281;12379.257244565333;11093.223474356779;11952.641420757369;12020.81968770467;12042.397880106004;12050.457729402176;745.8060904164929;761.9771406857775;768.6080099149447;769.8922150898878;770.2336175505352;755.735492577599;757.0650246945019;759.3735168485994;762.8474305138967;764.7361660227212;799.5242830515833;801.6512816924627;802.1216767639426;802.1497212954258;806.762005208462;797.9281864632181;801.907780605232;802.2619190344897;803.1005274093023;803.4175222963363;582.6183849578533;583.0903790087435;583.5477504933668;585.2654918077827;585.809611876142;11218.158638102175;11297.49161287744;11307.49116289769;11316.547338106466;11427.714307142305;10728.624498142606;10799.4060326682;10818;10924.2899211551;11412.372319522423;9532.428054316762;9595.90404095964;9703.417794932328;9806.705798825975;9908.35595686278;3226.1439210900085;3301.653326400741;3336.96663033369;3360.5631267935255;3383.881564145268;61691.383086169015;62928;62960.68519657418;66006;68000.3199967999;7555.16893141754;7584.582847943306;7701;7933.484323518953;7971.202879712098;16432.83567164337;16491.83508164903;16537.090460024574;16547.420840270534;16580.336786528405;6467.644279564669;6576.539642224999;6659.2008958925235;6830.521863469509;7000.194977577542;3733.4213196954515;3775.811209439572;3795.2409518096492;3816.790076545761;3825.923481530354;2720.455908818244;2821.6614006319373;2830.278279038832;2831.065748303055;2841.872115754796;471.11430510639775;477.23642172524376;478.8898553332753;480.29156993434407;492.1608657239398;476.64251811141645;501.3958180392618;538.0691403871247;538.8652836790802;540.5108376918895;7613.200613935568;7840.67023151552;7920.247576480225;7951.284384405431;8071.313938315191;477.2483338741496;501.208091215878;503.3381103848501;510.2142700241586;524.9947500524946;3716.108134047809;3810.466534685146;3838.961610383916;3982.046607482509;4033.556308806029;103047.48476257571;104909;106148.46925765321;110597.44701276442;112438;89689;89872.5506372464;91693;91981;94849.5257523708;77540.61229693815;79083;79083;79738;81759;7380.889286660812;7411.962940185264;7531.435142364235;7648.847023059397;7722.652480638272;46420.53579464297;48502.757486213755;48974.26538601995;49081;49362.25956610582;62966.370336297885;63732.68133659302;69368.30631693618;69630.65184674044;70463.64768176126;9536.189423899046;9900;10139.84790228162;10202.948985255027;10208.897911021091;11166;11199.384033878216;11206.327620342805;11220.831687524531;11280.492377842853;10019.899801002188;10070.446125462877;10110.39337639744;10301;10472.214583906085;9359.391639543408;9363.4381937084;9866.161376283097;10277.383356998604;10780.353178808982;9521.476318802532;9617.422954622745;9692.321537492307;10204.285700000928;10819.242653014528;9534.761630959281;9709.56306966174;9869.25980551476;9930.900690992998;10155.796884062425;9984.500774961369;10185.541650625888;10259.538320775433;10499.107575856138;10518.894811051792 16:08:40 INFO - PROCESS | 14599 | __end_tp_report 16:08:40 INFO - PROCESS | 14599 | __start_cc_report 16:08:40 INFO - PROCESS | 14599 | _x_x_mozilla_cycle_collect,895 16:08:40 INFO - PROCESS | 14599 | __end_cc_report 16:08:40 INFO - PROCESS | 14599 | __startTimestamp1471907320597__endTimestamp 16:08:40 INFO - PROCESS | 14599 | 16:08:40 INFO - PROCESS | 14599 | ------- Summary: start ------- 16:08:40 INFO - PROCESS | 14599 | Number of tests: 6 16:08:40 INFO - PROCESS | 14599 | 16:08:40 INFO - PROCESS | 14599 | [#0] dojo.html Cycles:165 Average:4674.91 Median:4833.15 stddev:509.74 (10.5%) stddev-sans-first:483.23 16:08:40 INFO - PROCESS | 14599 | Values: 2547.9 2600.7 2605.0 2609.0 2622.1 4633.0 4645.0 4670.3 4755.3 4763.1 4622.7 4699.3 4727.4 4758.3 4774.6 4153.4 4380.0 4403.2 4416.9 4438.6 4408.6 4418.5 4418.6 4450.0 4465.6 4264.2 4276.3 4306.1 4325.2 4383.4 4348.1 4351.9 4353.5 4356.7 4363.5 4324.9 4332.2 4344.8 4353.9 4363.0 4585.9 4651.5 4727.2 4767.6 4768.9 5068.5 5106.9 5110.8 5111.1 5114.2 5101.6 5106.9 5117.8 5122.9 5124.1 4610.3 4712.2 4753.0 4782.1 4790.1 5223.7 5246.3 5255.2 5258.5 5261.5 5031.6 5036.3 5039.6 5040.2 5044.9 4881.6 4947.6 4959.3 5087.8 5093.4 5016.8 5021.1 5034.3 5038.0 5040.0 5002.4 5014.7 5015.3 5015.4 5023.3 4084.1 4103.5 4110.1 4268.4 4273.6 3663.2 3671.9 3689.1 3702.1 3746.6 4377.0 4381.6 4384.3 4391.0 4393.3 5132.4 5139.0 5158.4 5158.7 5161.8 4214.4 4220.7 4265.2 4381.7 4390.5 4498.2 4513.5 4514.2 4521.6 4525.7 4722.0 4728.7 4729.9 4730.2 4730.4 4988.0 5034.8 5037.2 5038.8 5085.3 4819.9 4833.9 4834.0 4840.4 4840.8 5076.5 5078.4 5079.7 5080.1 5083.7 4923.9 4977.6 4989.5 5108.5 5113.4 4899.8 4916.1 4930.2 4942.6 4943.8 4892.6 4912.5 4927.0 4929.7 4940.6 4677.3 4833.2 4864.2 4883.3 4908.7 4981.2 4990.5 4995.7 4999.5 5033.7 4866.0 4894.6 4916.1 4921.1 4921.4 16:08:40 INFO - PROCESS | 14599 | 16:08:40 INFO - PROCESS | 14599 | [#1] ext.html Cycles:180 Average:46374.90 Median:182008.59 stddev:82795.06 (45.5%) stddev-sans-first:82955.87 16:08:40 INFO - PROCESS | 14599 | Values: 562.8 571.0 572.0 575.3 576.9 28844.4 29414.4 31689.8 31758.0 37974.6 36534.6 40924.4 41028.6 41042.2 41057.2 7557.2 7702.8 7704.5 7707.4 7707.8 7610.4 7683.3 7689.5 7693.5 7709.5 7671.9 7713.8 7717.8 7718.3 7722.7 7622.1 7658.6 7697.1 7703.2 7704.6 7451.4 7508.3 7513.2 7670.4 7678.2 37128.0 37579.1 37828.4 37892.4 37933.0 2624.2 2678.2 2700.9 2711.1 2722.6 28558.0 28829.3 28863.9 28931.0 29722.7 3391.8 3432.8 3520.5 3559.4 3583.2 251634.0 252026.0 252516.7 254371.0 256330.0 50827.7 51116.2 51137.7 51179.0 51214.0 45727.8 47964.5 51338.7 54310.2 54621.0 12877.2 13094.4 13172.4 13365.1 13422.3 10021.0 10103.5 10106.8 10112.3 10126.9 13439.6 15104.9 15613.5 15667.7 15696.7 5970.5 6107.3 6215.6 6273.3 6305.6 742.3 795.9 850.9 864.4 887.5 26053.6 27766.6 28046.4 28405.3 28457.7 888.2 925.8 947.3 988.4 1003.1 14695.6 14873.9 15025.6 15056.2 15195.0 357589.0 360434.0 360868.0 361062.0 361728.0 48670.0 48841.3 48928.8 49009.8 49026.3 994.4 1021.3 1025.2 1053.6 1159.5 25472.0 26826.6 27507.9 27628.5 28089.9 42182.4 42621.8 42623.0 42666.1 42739.8 318023.0 321453.2 321678.0 323298.0 324192.0 30268.4 36084.6 37760.6 39588.4 39591.4 40504.6 40514.2 40919.2 41878.4 41985.4 34779.5 35039.0 35248.5 35418.6 35606.0 33182.2 35165.0 35490.5 35496.8 35766.5 34816.0 34867.7 35069.1 35658.8 35719.0 29399.3 31725.0 31829.7 32184.7 32427.0 24176.0 24703.8 25150.7 25235.4 25403.2 16:08:40 INFO - PROCESS | 14599 | 16:08:40 INFO - PROCESS | 14599 | [#2] jquery.html Cycles:180 Average:23771.91 Median:4896.54 stddev:63786.34 (1302.7%) stddev-sans-first:63941.04 16:08:40 INFO - PROCESS | 14599 | Values: 354.5 361.8 361.9 373.4 376.4 15866.9 16898.3 16982.3 17149.7 17169.5 13920.9 14264.6 14398.8 15089.9 15462.7 4555.2 4898.9 4931.8 4931.9 4937.7 3605.2 3792.0 4894.2 5675.7 5941.0 6012.8 6013.4 6025.9 6026.8 6027.2 5815.2 5989.5 6028.8 6031.5 6038.2 4481.0 5248.5 5278.3 5280.9 5283.6 10275.2 10551.2 10556.4 10556.9 10560.0 1741.6 1781.4 2106.6 2156.6 2269.6 8562.1 8642.7 8745.7 8843.6 9026.4 1637.3 1656.7 1664.7 1674.4 1750.8 67104.3 67404.7 68296.0 69872.0 70929.6 9902.8 9974.7 9983.5 10058.5 10222.4 13727.0 13773.4 13774.8 13779.6 13790.9 6878.4 6989.1 7031.3 7116.4 7178.9 6439.1 6440.3 6637.3 6664.2 6725.2 4182.1 4262.0 4263.2 4366.8 4382.6 1644.6 1663.4 1689.9 1751.4 1774.9 794.5 811.7 813.2 873.9 914.1 15770.8 16299.8 16375.2 16478.3 17129.9 786.7 792.3 824.2 829.9 866.3 8758.7 8914.0 9139.4 9378.7 9455.0 371766.0 374534.0 381202.0 398848.0 399457.0 76934.6 78374.6 79683.6 79785.0 80673.6 807.8 851.5 872.0 874.5 874.9 14239.5 14282.7 14475.2 14656.6 15195.6 36281.0 37224.0 37269.3 38549.4 38988.6 51046.7 51562.7 51740.0 51775.7 52152.7 7182.4 7227.9 7254.9 7321.4 7391.2 9582.0 10893.8 10985.9 11031.8 11805.8 9451.9 9598.3 10119.5 10175.2 10309.3 10013.8 10082.5 10237.1 10330.8 10467.9 9875.3 10065.4 10179.7 10255.4 10724.6 7159.5 7296.6 7428.7 7455.6 7525.5 8685.7 9950.6 10272.5 10664.8 10742.3 16:08:40 INFO - PROCESS | 14599 | 16:08:40 INFO - PROCESS | 14599 | [#3] mootools.html Cycles:180 Average:5025.21 Median:5148.08 stddev:2867.84 (55.7%) stddev-sans-first:2861.75 16:08:40 INFO - PROCESS | 14599 | Values: 1235.8 1332.0 1384.0 1411.5 1677.6 6644.0 7468.7 7724.7 7732.7 7974.4 7729.0 7750.4 7837.6 7851.6 7851.7 2151.8 2180.7 2182.8 2184.8 2207.5 2090.3 2126.5 2150.5 2150.8 2156.3 2154.5 2180.4 2186.4 2186.9 2199.0 2129.0 2132.1 2133.4 2134.3 2135.6 2058.2 2118.2 2119.0 2122.9 2134.8 7752.6 7755.7 7857.8 7866.4 7885.1 4390.8 4508.3 4519.6 4521.4 4531.3 2813.0 2938.3 2970.7 2973.7 2985.0 908.5 916.4 924.4 932.2 934.6 10668.7 10762.2 10769.1 10771.8 10783.6 3912.5 3924.1 4056.5 4059.3 4066.4 8482.0 8498.7 8538.8 8540.2 8543.5 4377.1 4377.9 4379.3 4380.2 4384.5 3615.9 3989.2 4075.5 4093.4 4133.5 3323.7 3371.8 3454.7 3481.6 3487.2 1012.0 1027.0 1027.7 1034.9 1061.2 591.1 741.7 755.4 763.0 768.1 5123.3 5172.9 5208.7 5208.8 5334.0 830.4 886.7 923.6 924.3 932.8 3322.8 3408.8 3445.7 3526.9 3609.0 9547.6 9639.4 9739.7 9740.2 9773.1 9668.7 9671.3 9673.0 9677.3 9681.0 7097.4 7332.1 7390.7 7393.4 7396.8 4911.3 4941.4 5010.6 5058.9 5080.8 8506.7 8674.6 8897.3 8958.0 8985.3 8949.4 9066.3 9113.7 9114.9 9119.3 5353.2 5854.8 5886.5 5995.4 6000.0 7292.2 7455.9 7461.4 7489.3 7503.7 6530.4 6533.5 6585.6 6669.8 6799.6 6370.3 6529.8 6582.0 6729.2 6784.7 5831.7 5923.1 5932.9 5939.2 5941.0 4474.7 4508.2 4551.7 4567.1 4642.9 4292.7 4294.7 4366.4 4439.3 4472.8 16:08:40 INFO - PROCESS | 14599 | 16:08:40 INFO - PROCESS | 14599 | [#4] prototype.html Cycles:180 Average:4136.37 Median:4764.59 stddev:1201.06 (25.2%) stddev-sans-first:1169.24 16:08:40 INFO - PROCESS | 14599 | Values: 291.3 296.1 303.4 305.3 305.8 4807.3 4808.5 4816.9 4824.3 4846.7 4693.9 4742.5 4761.0 4768.2 4789.4 3566.7 3668.6 3695.8 3708.6 3770.8 3723.9 3727.8 3756.3 3769.0 3782.5 3692.0 3698.6 3706.2 3710.8 3714.4 3513.8 3580.5 3677.2 3680.4 3729.6 3245.9 3247.2 3249.5 3255.4 3258.2 4647.9 4649.7 4654.7 4659.3 4663.4 4138.5 4260.4 4265.4 4274.1 4294.8 4915.0 4934.4 4937.4 4937.8 4939.0 3606.6 3618.4 3622.8 3624.0 3636.9 5156.3 5176.0 5178.1 5211.4 5255.3 3575.5 3702.1 3702.8 3713.2 3731.6 3719.8 3727.1 3727.8 3733.5 3734.1 4223.8 4238.0 4242.3 4255.1 4261.6 4715.4 4937.2 4947.2 4966.3 4988.0 1239.0 1258.8 1261.9 1267.4 1268.8 794.2 795.2 805.6 824.9 826.6 4165.6 4383.6 4387.6 4413.9 4422.6 5132.1 5143.5 5144.3 5186.6 5188.8 4367.1 4368.3 4369.9 4383.8 4398.9 2593.6 2690.0 2699.5 2711.2 2728.4 4816.6 4817.8 4823.4 4829.7 4839.0 5068.0 5200.6 5216.4 5241.7 5302.5 4736.7 4802.4 4804.6 4827.5 4839.0 5098.7 5114.6 5116.7 5138.9 5172.6 4885.0 4975.6 5060.6 5064.2 5081.3 4791.5 4831.7 4832.4 4834.1 4835.3 3621.7 3632.4 3632.7 3660.9 3666.7 4990.9 5100.7 5126.2 5137.6 5140.7 4858.3 4908.9 4937.0 4944.6 4951.2 4943.2 4952.7 4956.1 4956.3 5019.9 4726.7 4901.4 4914.5 4929.1 4950.9 4776.9 4846.5 4951.0 5004.7 5006.6 4877.3 4887.9 4926.5 4945.3 4950.4 16:08:40 INFO - PROCESS | 14599 | 16:08:40 INFO - PROCESS | 14599 | [#5] yui.html Cycles:180 Average:18107.31 Median:539.69 stddev:27661.13 (5125.4%) stddev-sans-first:27707.38 16:08:40 INFO - PROCESS | 14599 | Values: 568.6 581.2 611.2 624.3 630.1 11344.9 12292.0 12298.4 12313.6 12379.3 11093.2 11952.6 12020.8 12042.4 12050.5 745.8 762.0 768.6 769.9 770.2 755.7 757.1 759.4 762.8 764.7 799.5 801.7 802.1 802.1 806.8 797.9 801.9 802.3 803.1 803.4 582.6 583.1 583.5 585.3 585.8 11218.2 11297.5 11307.5 11316.5 11427.7 10728.6 10799.4 10818.0 10924.3 11412.4 9532.4 9595.9 9703.4 9806.7 9908.4 3226.1 3301.7 3337.0 3360.6 3383.9 61691.4 62928.0 62960.7 66006.0 68000.3 7555.2 7584.6 7701.0 7933.5 7971.2 16432.8 16491.8 16537.1 16547.4 16580.3 6467.6 6576.5 6659.2 6830.5 7000.2 3733.4 3775.8 3795.2 3816.8 3825.9 2720.5 2821.7 2830.3 2831.1 2841.9 471.1 477.2 478.9 480.3 492.2 476.6 501.4 538.1 538.9 540.5 7613.2 7840.7 7920.2 7951.3 8071.3 477.2 501.2 503.3 510.2 525.0 3716.1 3810.5 3839.0 3982.0 4033.6 103047.5 104909.0 106148.5 110597.4 112438.0 89689.0 89872.6 91693.0 91981.0 94849.5 77540.6 79083.0 79083.0 79738.0 81759.0 7380.9 7412.0 7531.4 7648.8 7722.7 46420.5 48502.8 48974.3 49081.0 49362.3 62966.4 63732.7 69368.3 69630.7 70463.6 9536.2 9900.0 10139.8 10202.9 10208.9 11166.0 11199.4 11206.3 11220.8 11280.5 10019.9 10070.4 10110.4 10301.0 10472.2 9359.4 9363.4 9866.2 10277.4 10780.4 9521.5 9617.4 9692.3 10204.3 10819.2 9534.8 9709.6 9869.3 9930.9 10155.8 9984.5 10185.5 10259.5 10499.1 10518.9 16:08:40 INFO - PROCESS | 14599 | -------- Summary: end -------- 16:08:40 INFO - PROCESS | 14599 | 16:08:41 INFO - TEST-INFO | 14599: exit 0 16:08:41 INFO - TEST-OK | dromaeo_css | took 1120317ms 16:08:41 INFO - TEST-START | kraken 16:08:41 INFO - operating with platform_type : linux_ 16:08:41 INFO - Initialising browser for kraken test... 16:08:41 INFO - TEST-INFO | started process 14908 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppbcRdb/profile http://localhost:35586/getInfo.html) 16:08:45 INFO - PROCESS | 14908 | __metrics Screen width/height:1600/1200 16:08:45 INFO - PROCESS | 14908 | colorDepth:24 16:08:45 INFO - PROCESS | 14908 | Browser inner width/height: 1024/697 16:08:45 INFO - PROCESS | 14908 | __metrics 16:08:46 INFO - PROCESS | 14908 | 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" 16:08:46 INFO - PROCESS | 14908 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:08:46 INFO - PROCESS | 14908 | console.error: PushService: 16:08:46 INFO - PROCESS | 14908 | stateChangeProcessEnqueue: Error transitioning state 16:08:46 INFO - PROCESS | 14908 | UnknownError 16:08:47 INFO - TEST-INFO | 14908: exit 0 16:08:47 INFO - Browser initialized. 16:08:47 INFO - Running cycle 1/1 for kraken test... 16:08:47 INFO - TEST-INFO | started process 14990 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppbcRdb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:08:59 INFO - PROCESS | 14990 | RSS: Main: 175853568 16:08:59 INFO - PROCESS | 14990 | 16:09:02 INFO - PROCESS | 14990 | Cycle 1(1): loaded http://localhost:35586/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35586/tests/kraken/driver.html?testName=audio-beat-detection) 16:09:03 INFO - PROCESS | 14990 | RSS: Main: 236625920 16:09:03 INFO - PROCESS | 14990 | 16:09:06 INFO - PROCESS | 14990 | Cycle 1(1): loaded http://localhost:35586/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35586/tests/kraken/driver.html?testName=audio-dft) 16:09:06 INFO - PROCESS | 14990 | RSS: Main: 226783232 16:09:06 INFO - PROCESS | 14990 | 16:09:10 INFO - PROCESS | 14990 | Cycle 1(1): loaded http://localhost:35586/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35586/tests/kraken/driver.html?testName=audio-fft) 16:09:10 INFO - PROCESS | 14990 | RSS: Main: 300883968 16:09:10 INFO - PROCESS | 14990 | 16:09:12 INFO - PROCESS | 14990 | Cycle 1(1): loaded http://localhost:35586/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35586/tests/kraken/driver.html?testName=audio-oscillator) 16:09:13 INFO - PROCESS | 14990 | RSS: Main: 210378752 16:09:13 INFO - PROCESS | 14990 | 16:09:15 INFO - PROCESS | 14990 | Cycle 1(1): loaded http://localhost:35586/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35586/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:09:16 INFO - PROCESS | 14990 | RSS: Main: 214949888 16:09:16 INFO - PROCESS | 14990 | 16:09:19 INFO - PROCESS | 14990 | Cycle 1(1): loaded http://localhost:35586/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35586/tests/kraken/driver.html?testName=imaging-darkroom) 16:09:20 INFO - PROCESS | 14990 | RSS: Main: 251191296 16:09:20 INFO - PROCESS | 14990 | 16:09:23 INFO - PROCESS | 14990 | Cycle 1(1): loaded http://localhost:35586/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35586/tests/kraken/driver.html?testName=imaging-desaturate) 16:09:24 INFO - PROCESS | 14990 | RSS: Main: 244232192 16:09:24 INFO - PROCESS | 14990 | 16:09:27 INFO - PROCESS | 14990 | Cycle 1(1): loaded http://localhost:35586/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35586/tests/kraken/driver.html?testName=json-parse-financial) 16:09:27 INFO - PROCESS | 14990 | RSS: Main: 247406592 16:09:27 INFO - PROCESS | 14990 | 16:09:29 INFO - PROCESS | 14990 | Cycle 1(1): loaded http://localhost:35586/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35586/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:09:30 INFO - PROCESS | 14990 | RSS: Main: 211542016 16:09:30 INFO - PROCESS | 14990 | 16:09:32 INFO - PROCESS | 14990 | Cycle 1(1): loaded http://localhost:35586/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35586/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:09:32 INFO - PROCESS | 14990 | RSS: Main: 218968064 16:09:32 INFO - PROCESS | 14990 | 16:09:35 INFO - PROCESS | 14990 | Cycle 1(1): loaded http://localhost:35586/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35586/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:09:35 INFO - PROCESS | 14990 | RSS: Main: 224194560 16:09:35 INFO - PROCESS | 14990 | 16:09:38 INFO - PROCESS | 14990 | Cycle 1(1): loaded http://localhost:35586/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35586/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:09:39 INFO - PROCESS | 14990 | RSS: Main: 219041792 16:09:39 INFO - PROCESS | 14990 | 16:09:42 INFO - PROCESS | 14990 | Cycle 1(1): loaded http://localhost:35586/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35586/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:09:42 INFO - PROCESS | 14990 | RSS: Main: 221732864 16:09:42 INFO - PROCESS | 14990 | 16:09:44 INFO - PROCESS | 14990 | Cycle 1(1): loaded http://localhost:35586/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35586/tests/kraken/driver.html?testName=ai-astar) 16:09:44 INFO - PROCESS | 14990 | RSS: Main: 273108992 16:09:44 INFO - PROCESS | 14990 | 16:09:44 INFO - PROCESS | 14990 | __start_tp_report 16:09:44 INFO - PROCESS | 14990 | _x_x_mozilla_page_load 16:09:44 INFO - PROCESS | 14990 | _x_x_mozilla_page_load_details 16:09:44 INFO - PROCESS | 14990 | |i|pagename|runs| 16:09:44 INFO - PROCESS | 14990 | |0;ai-astar;99;113;113;115;114;113;120;113;113;112 16:09:44 INFO - PROCESS | 14990 | |1;audio-beat-detection;155;126;147;184;121;148;154;122;181;124 16:09:44 INFO - PROCESS | 14990 | |2;audio-dft;163;169;162;163;161;162;161;161;161;160 16:09:44 INFO - PROCESS | 14990 | |3;audio-fft;75;76;119;121;77;77;76;116;105;77 16:09:44 INFO - PROCESS | 14990 | |4;audio-oscillator;89;88;140;87;88;86;133;88;87;144 16:09:44 INFO - PROCESS | 14990 | |5;imaging-gaussian-blur;118;118;118;118;117;119;118;119;118;118 16:09:44 INFO - PROCESS | 14990 | |6;imaging-darkroom;147;146;146;146;147;146;145;146;146;147 16:09:44 INFO - PROCESS | 14990 | |7;imaging-desaturate;95;95;95;94;95;94;95;95;95;95 16:09:44 INFO - PROCESS | 14990 | |8;json-parse-financial;70;65;66;66;67;67;69;73;66;66 16:09:44 INFO - PROCESS | 14990 | |9;json-stringify-tinderbox;66;67;67;67;68;67;67;66;66;66 16:09:44 INFO - PROCESS | 14990 | |10;stanford-crypto-aes;82;82;82;82;85;82;87;83;87;83 16:09:44 INFO - PROCESS | 14990 | |11;stanford-crypto-ccm;137;149;133;133;134;133;140;134;149;139 16:09:44 INFO - PROCESS | 14990 | |12;stanford-crypto-pbkdf2;174;181;177;172;176;178;171;171;169;171 16:09:44 INFO - PROCESS | 14990 | |13;stanford-crypto-sha256-iterative;72;70;70;70;67;68;72;72;67;71 16:09:44 INFO - PROCESS | 14990 | __end_tp_report 16:09:44 INFO - PROCESS | 14990 | __start_cc_report 16:09:44 INFO - PROCESS | 14990 | _x_x_mozilla_cycle_collect,1997 16:09:44 INFO - PROCESS | 14990 | __end_cc_report 16:09:44 INFO - PROCESS | 14990 | __startTimestamp1471907384936__endTimestamp 16:09:44 INFO - PROCESS | 14990 | 16:09:44 INFO - PROCESS | 14990 | ------- Summary: start ------- 16:09:44 INFO - PROCESS | 14990 | Number of tests: 14 16:09:44 INFO - PROCESS | 14990 | 16:09:44 INFO - PROCESS | 14990 | [#0] ai-astar Cycles:10 Average:112.50 Median:113.50 stddev:5.25 (4.6%) stddev-sans-first:2.40 16:09:44 INFO - PROCESS | 14990 | Values: 99.0 113.0 113.0 115.0 114.0 113.0 120.0 113.0 113.0 112.0 16:09:44 INFO - PROCESS | 14990 | 16:09:44 INFO - PROCESS | 14990 | [#1] audio-beat-detection Cycles:10 Average:146.20 Median:151.00 stddev:23.34 (15.5%) stddev-sans-first:24.54 16:09:44 INFO - PROCESS | 14990 | Values: 155.0 126.0 147.0 184.0 121.0 148.0 154.0 122.0 181.0 124.0 16:09:44 INFO - PROCESS | 14990 | 16:09:44 INFO - PROCESS | 14990 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.00 stddev:2.54 (1.6%) stddev-sans-first:2.68 16:09:44 INFO - PROCESS | 14990 | Values: 163.0 169.0 162.0 163.0 161.0 162.0 161.0 161.0 161.0 160.0 16:09:44 INFO - PROCESS | 14990 | 16:09:44 INFO - PROCESS | 14990 | [#3] audio-fft Cycles:10 Average:91.90 Median:76.00 stddev:20.52 (27.0%) stddev-sans-first:20.84 16:09:44 INFO - PROCESS | 14990 | Values: 75.0 76.0 119.0 121.0 77.0 77.0 76.0 116.0 105.0 77.0 16:09:44 INFO - PROCESS | 14990 | 16:09:44 INFO - PROCESS | 14990 | [#4] audio-oscillator Cycles:10 Average:103.00 Median:87.50 stddev:24.99 (28.6%) stddev-sans-first:25.99 16:09:44 INFO - PROCESS | 14990 | Values: 89.0 88.0 140.0 87.0 88.0 86.0 133.0 88.0 87.0 144.0 16:09:44 INFO - PROCESS | 14990 | 16:09:44 INFO - PROCESS | 14990 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 16:09:44 INFO - PROCESS | 14990 | Values: 118.0 118.0 118.0 118.0 117.0 119.0 118.0 119.0 118.0 118.0 16:09:44 INFO - PROCESS | 14990 | 16:09:44 INFO - PROCESS | 14990 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 16:09:44 INFO - PROCESS | 14990 | Values: 147.0 146.0 146.0 146.0 147.0 146.0 145.0 146.0 146.0 147.0 16:09:44 INFO - PROCESS | 14990 | 16:09:44 INFO - PROCESS | 14990 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 16:09:44 INFO - PROCESS | 14990 | Values: 95.0 95.0 95.0 94.0 95.0 94.0 95.0 95.0 95.0 95.0 16:09:44 INFO - PROCESS | 14990 | 16:09:44 INFO - PROCESS | 14990 | [#8] json-parse-financial Cycles:10 Average:67.50 Median:67.00 stddev:2.46 (3.7%) stddev-sans-first:2.44 16:09:44 INFO - PROCESS | 14990 | Values: 70.0 65.0 66.0 66.0 67.0 67.0 69.0 73.0 66.0 66.0 16:09:44 INFO - PROCESS | 14990 | 16:09:44 INFO - PROCESS | 14990 | [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 16:09:44 INFO - PROCESS | 14990 | Values: 66.0 67.0 67.0 67.0 68.0 67.0 67.0 66.0 66.0 66.0 16:09:44 INFO - PROCESS | 14990 | 16:09:44 INFO - PROCESS | 14990 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:83.00 stddev:2.07 (2.5%) stddev-sans-first:2.12 16:09:44 INFO - PROCESS | 14990 | Values: 82.0 82.0 82.0 82.0 85.0 82.0 87.0 83.0 87.0 83.0 16:09:44 INFO - PROCESS | 14990 | 16:09:44 INFO - PROCESS | 14990 | [#11] stanford-crypto-ccm Cycles:10 Average:138.10 Median:138.00 stddev:6.28 (4.6%) stddev-sans-first:6.65 16:09:44 INFO - PROCESS | 14990 | Values: 137.0 149.0 133.0 133.0 134.0 133.0 140.0 134.0 149.0 139.0 16:09:44 INFO - PROCESS | 14990 | 16:09:44 INFO - PROCESS | 14990 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.00 Median:175.00 stddev:3.86 (2.2%) stddev-sans-first:4.09 16:09:44 INFO - PROCESS | 14990 | Values: 174.0 181.0 177.0 172.0 176.0 178.0 171.0 171.0 169.0 171.0 16:09:44 INFO - PROCESS | 14990 | 16:09:44 INFO - PROCESS | 14990 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:70.50 stddev:1.97 (2.8%) stddev-sans-first:1.94 16:09:44 INFO - PROCESS | 14990 | Values: 72.0 70.0 70.0 70.0 67.0 68.0 72.0 72.0 67.0 71.0 16:09:44 INFO - PROCESS | 14990 | -------- Summary: end -------- 16:09:44 INFO - PROCESS | 14990 | 16:09:46 INFO - TEST-INFO | 14990: exit 0 16:09:46 INFO - TEST-OK | kraken | took 64796ms 16:09:46 INFO - SUITE-END | took 1185s 16:09:46 INFO - Completed test suite (00:19:45) 16:09:46 INFO - javascript benchmark 16:09:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2547.898084076636, 2600.7139214686385, 2604.986975065124, 2609.0, 2622.1215892675955, 4633.027064316498, 4645.047765208133, 4670.322803193535, 4755.3104799804005, 4763.1188230177395, 4622.676412651116, 4699.318598803172, 4727.409073865775, 4758.262469317261, 4774.594159496447, 4153.397757325186, 4379.956200437987, 4403.163398954204, 4416.889577760549, 4438.644908407319, 4408.603225709701, 4418.469783625969, 4418.5581441855875, 4450.043240703249, 4465.598096171344, 4264.189803937273, 4276.3157894737005, 4306.0957198987935, 4325.178216138924, 4383.408239887606, 4348.130373925228, 4351.912961740779, 4353.455818022747, 4356.738595684269, 4363.454568178978, 4324.913501729948, 4332.220200363933, 4344.847930322424, 4353.891152721176, 4363.040131171138, 4585.862424127282, 4651.511591282901, 4727.172744769686, 4767.570918617306, 4768.904621907543, 5068.543831055223, 5106.897862042739, 5110.795568177268, 5111.08000559899, 5114.207297868837, 5101.591872650179, 5106.872328191787, 5117.82087626935, 5122.871928201787, 5124.103281925648, 4610.2854057621125, 4712.222483290218, 4753.04939012199, 4782.13921494131, 4790.089882922233, 5223.660462069954, 5246.291750613618, 5255.237990491358, 5258.5267325940085, 5261.473852614785, 5031.597472202215, 5036.29491871131, 5039.647224694236, 5040.168372218543, 5044.899102018013, 4881.633877459205, 4947.628927830355, 4959.2809042688605, 5087.796488140507, 5093.414257360377, 5016.824411145592, 5021.07110184617, 5034.270030845507, 5037.974810125926, 5040.042391945519, 5002.399712034579, 5014.749262536859, 5015.27278544609, 5015.398152221756, 5023.296738456619, 4084.0606660468256, 4103.528094269138, 4110.095778928631, 4268.40242366069, 4273.615374616299, 3663.175785448253, 3671.908202294964, 3689.1146124929824, 3702.1485058436174, 3746.550413950289, 4376.978115109404, 4381.583749543788, 4384.254676704968, 4391.012022294958, 4393.275109606943, 5132.358455193101, 5139.023585518814, 5158.380994280636, 5158.664686795346, 5161.845144645667, 4214.367844823301, 4220.704550681423, 4265.232258193493, 4381.737095774264, 4390.53899340571, 4498.235299999008, 4513.50351461339, 4514.210013247734, 4521.570450807168, 4525.683202175816, 4721.976390118096, 4728.692634978715, 4729.9054018920115, 4730.2195137803255, 4730.385049943554, 4987.975060124676, 5034.84895453137, 5037.244413338029, 5038.773255203451, 5085.313482679939, 4819.927701084556, 4833.903321933612, 4833.95166048335, 4840.443349014768, 4840.782164802522, 5076.492350764894, 5078.415982162099, 5079.746012699276, 5080.060188865072, 5083.72039537829, 4923.852284431473, 4977.552020318189, 4989.451160372429, 5108.463611320906, 5113.437521872516, 4899.779509921991, 4916.115099282163, 4930.235813448921, 4942.6293028023765, 4943.802247910044, 4892.633052521004, 4912.508749125202, 4927.01459708067, 4929.6549241554185, 4940.604751619933, 4677.3451716759, 4833.154198015403, 4864.246041863516, 4883.291922671264, 4908.730019848943, 4981.227909674007, 4990.50094990498, 4995.700257984533, 4999.475055119306, 5033.672811267256, 4866.0, 4894.632902532253, 4916.115099282163, 4921.138800709933, 4921.434035086011], "value": 4640.988368066739, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.800205926896, 571.0149991265068, 571.959962802604, 575.3239943066898, 576.8500189950613, 28844.423111537784, 29414.411711765777, 31689.841550792215, 31758.04725858225, 37974.62025379745, 36534.634653653455, 40924.38613420801, 41028.58971410285, 41042.179156416925, 41057.178856422855, 7557.24427557244, 7702.845943081135, 7704.499207551519, 7707.383409327268, 7707.845843083135, 7610.35311998478, 7683.34691551216, 7689.461737678364, 7693.538387696728, 7709.537427754324, 7671.884921726179, 7713.807154821118, 7717.768466946, 7718.266764657348, 7722.691092356327, 7622.085349758009, 7658.617069146549, 7697.076350837935, 7703.22967703228, 7704.576248306341, 7451.403887688972, 7508.2867127622785, 7513.248675132443, 7670.424718146106, 7678.155402905676, 37128.0, 37579.060523486856, 37828.43257351142, 37892.43161352582, 37933.0, 2624.238970698495, 2678.1965410377, 2700.9189724308303, 2711.0917842522776, 2722.6324446199706, 28558.0, 28829.279268018257, 28863.855680721463, 28931.0, 29722.70277297221, 3391.8473668684724, 3432.828358582061, 3520.507129001942, 3559.359315323241, 3583.175869549992, 251634.0, 252026.0, 252516.73741631358, 254371.0, 256330.0, 50827.74586127046, 51116.23325650118, 51137.744311278206, 51179.0, 51214.0, 45727.77136114298, 47964.5203547967, 51338.74330628398, 54310.18534721982, 54621.0, 12877.227366358049, 13094.410751516014, 13172.407241674147, 13365.131266467648, 13422.261775602436, 10021.0, 10103.494825258707, 10106.797864042677, 10112.342697724624, 10126.949365253127, 13439.596812095653, 15104.924475377773, 15613.453529126426, 15667.686646267011, 15696.686066278611, 5970.4775282302735, 6107.305080426367, 6215.627062376181, 6273.341299163613, 6305.5901366411035, 742.254034695128, 795.9243871832167, 850.9234168924703, 864.4337958637103, 887.5256635416898, 26053.60919586208, 27766.583501247496, 28046.43907121846, 28405.289867753472, 28457.715422845922, 888.1651247827022, 925.833349997007, 947.3131979314942, 988.3526290279734, 1003.0771690045176, 14695.632609184855, 14873.851261487463, 15025.624359391102, 15056.171910544806, 15195.0, 357589.0, 360434.0, 360868.0, 361062.0, 361728.0, 48670.0, 48841.26738098932, 48928.75535622299, 49009.75495122502, 49026.26460603094, 994.3785134291068, 1021.3259248895694, 1025.1849779425374, 1053.5733028123623, 1159.5014143918197, 25472.0, 26826.59760103561, 27507.862460687567, 27628.470540053757, 28089.859550702935, 42182.36726449167, 42621.78689106535, 42623.0, 42666.14667706691, 42739.78630106829, 318023.0, 321453.17820232245, 321678.0, 323298.0, 324192.0, 30268.394632107676, 36084.63915360813, 37760.62239377571, 39588.406173906835, 39591.40612890751, 40504.59495405008, 40514.1897162061, 40919.1816163681, 41878.37182442205, 41985.37021944612, 34779.478307825906, 35039.0, 35248.47127293144, 35418.64581354154, 35606.0, 33182.19311620505, 35165.0, 35490.46764298486, 35496.82251588725, 35766.46350304696, 34816.0, 34867.65132348644, 35069.123271917386, 35658.82170589131, 35719.0, 29399.26501837471, 31725.0, 31829.6817031836, 32184.678153218167, 32427.0, 24175.978002749656, 24703.752962470866, 25150.748492514842, 25235.369115772253, 25403.20169055638], "value": 16976.77744538628, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.4859953068052, 361.81185783392647, 361.9113317237277, 373.3932359915138, 376.3770959062752, 15866.920665396672, 16898.32406703732, 16982.32070717173, 17149.657006859856, 17169.484915452525, 13920.930395348034, 14264.643383915381, 14398.784018239734, 15089.92455037726, 15462.690746185097, 4555.180067587841, 4898.902021959559, 4931.791711030803, 4931.876703082434, 4937.6790508617005, 3605.242898991215, 3791.981040094796, 4894.1679914414635, 5675.659460432387, 5940.970295148518, 6012.789552365668, 6013.398660133996, 6025.939740602582, 6026.789062382817, 6027.186329845481, 5815.214945982301, 5989.490893274077, 6028.849278768022, 6031.45716885478, 6038.154658347835, 4480.955190448087, 5248.475152484759, 5278.261043453919, 5280.894382112375, 5283.577313814885, 10275.177985761122, 10551.20865935058, 10556.366618002867, 10556.947215263952, 10560.0, 1741.5907261793468, 1781.376518218626, 2106.620808254529, 2156.590247852903, 2269.5914735347633, 8562.14378562145, 8642.65429382824, 8745.650173993032, 8843.646254149826, 9026.368154229142, 1637.287779815784, 1656.6686662667394, 1664.6920319740766, 1674.3888480704577, 1750.8424241818298, 67104.32895671029, 67404.6629766848, 68296.0, 69872.0, 70929.64535177343, 9902.752431189278, 9974.650887218913, 9983.500824958723, 10058.547365368577, 10222.437765922945, 13727.0, 13773.380197890918, 13774.793378099337, 13779.586612401645, 13790.862091378958, 6878.415334696507, 6989.126359205099, 7031.29687031303, 7116.395106415909, 7178.928210717931, 6439.130717353098, 6440.323766004596, 6637.303083176197, 6664.200295964515, 6725.226598941086, 4182.121754431542, 4261.97869010653, 4263.232618128704, 4366.759828209415, 4382.649388048949, 1644.629958259406, 1663.3512929957326, 1689.923953422099, 1751.4045224623435, 1774.9112544372729, 794.4557977785236, 811.679386642273, 813.2233716800441, 873.9169778870997, 914.0996118822954, 15770.842291577166, 16299.755503667455, 16375.181240937905, 16478.34086636521, 17129.914350428167, 786.7364432915037, 792.3423558446476, 824.1511243419287, 829.9377546683902, 866.27233124176, 8758.666964884762, 8914.0, 9139.360244782802, 9378.671746488977, 9455.0, 371766.0, 374534.0, 381202.0, 398848.0, 399457.0, 76934.61532692413, 78374.608126959, 79683.60158199172, 79785.0, 80673.57979260631, 807.7576726981882, 851.5316575883239, 872.023333866074, 874.5277550122989, 874.9475031498131, 14239.50161744334, 14282.714345713235, 14475.203863787592, 14656.633584160481, 15195.620109497351, 36281.0, 37224.0, 37269.25461490701, 38549.4217586742, 38988.61011389963, 51046.74476627593, 51562.74218628883, 51740.0, 51775.74112129415, 52152.7392363051, 7182.425405967615, 7227.8554428912175, 7254.854902901807, 7321.3776828968, 7391.186969433251, 9581.952090239784, 10893.782124357627, 10985.890141098806, 11031.779364412827, 11805.76388472243, 9451.858222126537, 9598.32811703174, 10119.494025298558, 10175.236857235588, 10309.278350515691, 10013.849792252977, 10082.495875206358, 10237.129843963048, 10330.845037324296, 10467.947660261954, 9875.308728388944, 10065.396076235156, 10179.694609161737, 10255.384676919408, 10724.571017159225, 7159.534630249017, 7296.562206267641, 7428.73999410018, 7455.627218639155, 7525.548467091992, 8685.739427817176, 9950.601975921172, 10272.486375681037, 10664.786704266027, 10742.3017503862], "value": 7869.353295017035, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1235.8455193100863, 1331.966700832479, 1384.0173476831449, 1411.46364381535, 1677.605762645778, 6644.0, 7468.738594149206, 7724.652390642421, 7732.690692372298, 7974.441789074767, 7729.033870766154, 7750.3799696024325, 7837.568933708644, 7851.60741962901, 7851.685932562705, 2151.7848215178474, 2180.7056047433553, 2182.792634699701, 2184.814290785277, 2207.47020715028, 2090.278853795438, 2126.5215326551556, 2150.5483848391777, 2150.7526634437004, 2156.2992027591017, 2154.515234072337, 2180.4439867833757, 2186.3768825884626, 2186.912523499066, 2198.9780102199015, 2129.0419311309897, 2132.1045161032403, 2133.4453042208984, 2134.274346722106, 2135.6049130910833, 2058.1870161286356, 2118.2480219522004, 2118.9788102118937, 2122.9150833966623, 2134.7651758306574, 7752.612369381508, 7755.689772409097, 7857.764267071997, 7866.370690344758, 7885.093214280317, 4390.824367025347, 4508.2561377372695, 4519.615832654195, 4521.412216411845, 4531.3203019547, 2812.9718702812916, 2938.32418543734, 2970.7177818107243, 2973.702629737009, 2984.970150298491, 908.4957848394139, 916.4272329793879, 924.3806649544754, 932.1936524905975, 934.6074648647516, 10668.679939601747, 10762.192835537366, 10769.084627806646, 10771.78456430867, 10783.5686572537, 3912.5304963404574, 3924.0778417071965, 4056.51321841375, 4059.330210515232, 4066.369712694537, 8481.957590212009, 8498.74503764888, 8538.829223415496, 8540.23137917578, 8543.487390756574, 4377.124575084996, 4377.934330985037, 4379.299312110047, 4380.211561918885, 4384.473863136444, 3615.891523254307, 3989.1822176453757, 4075.5109386873764, 4093.4064560639135, 4133.545310015896, 3323.667633236657, 3371.780834245766, 3454.671806178409, 3481.599616044137, 3487.163080860575, 1011.9696409107738, 1027.0499787696351, 1027.712240572641, 1034.896510348959, 1061.2253055269696, 591.1369400674977, 741.6959046790897, 755.3881356101575, 762.9961850190714, 768.0744702633314, 5123.257127716534, 5172.8965420691375, 5208.744534665834, 5208.791648334024, 5333.973330133324, 830.4187069051688, 886.7029545102334, 923.5843870258276, 924.3344791749929, 932.8292992294762, 3322.7674062815854, 3408.812515311632, 3445.6554344565843, 3526.9118272043406, 3608.963910360915, 9547.570359333708, 9639.421634701941, 9739.707808765606, 9740.172085372822, 9773.12041916231, 9668.661596844076, 9671.323007389416, 9672.95163524178, 9677.274204434554, 9681.031896810262, 7097.361237488651, 7332.0834895638045, 7390.7413240536325, 7393.371563417169, 7396.815079622945, 4911.3369695090705, 4941.407031156285, 5010.647125276228, 5058.898822023465, 5080.796768129233, 8506.659733610833, 8674.566271686517, 8897.2882169425, 8957.955210223907, 8985.326100542616, 8949.418287811272, 9066.320025998208, 9113.726588202364, 9114.908850911672, 9119.270458363448, 5353.197020446964, 5854.765809367577, 5886.529077673861, 5995.370486098896, 6000.039993601003, 7292.234315396807, 7455.925440745523, 7461.365783908212, 7489.325960663567, 7503.699852005859, 6530.412262896362, 6533.509986750918, 6585.6377899216, 6669.7665581704405, 6799.626020568916, 6370.331115232834, 6529.771457998947, 6582.0, 6729.158855143107, 6784.728610855511, 5831.70841457917, 5923.111533269872, 5932.8813423732145, 5939.227900373096, 5941.019731744386, 4474.731516109044, 4508.233600288025, 4551.704139230939, 4567.109413664436, 4642.907141857211, 4292.720973136861, 4294.677899157638, 4366.410534577792, 4439.334099885043, 4472.776361181993], "value": 4023.8423820427624, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.3226747811339, 296.120522049513, 303.4446962059431, 305.3328477277151, 305.81803826723103, 4807.254875494304, 4808.495108013661, 4816.903661926764, 4824.324594556765, 4846.733429661367, 4693.929591056137, 4742.549457801503, 4761.0, 4768.1894078006735, 4789.401324834395, 3566.6968307693814, 3668.633136686337, 3695.833687484056, 3708.627807711137, 3770.830312635924, 3723.869664561741, 3727.813609319523, 3756.2863056019405, 3769.0, 3782.451544526042, 3692.0, 3698.630136986293, 3706.240220754739, 3710.8330125144435, 3714.4213709173628, 3513.7716048456896, 3580.516630254934, 3677.2461645362637, 3680.411134218539, 3729.601399475197, 3245.8863939761995, 3247.236899328656, 3249.496328069153, 3255.446574082388, 3258.169166862435, 4647.883802904955, 4649.697769644962, 4654.697444666086, 4659.301104834268, 4663.417072865892, 4138.503379594468, 4260.4248426462655, 4265.3815196796295, 4274.059706864485, 4294.849680261207, 4914.950850491485, 4934.445649620394, 4937.382827146606, 4937.827176048857, 4938.950610493921, 3606.5672119345586, 3618.3848745713294, 3622.8188590570367, 3623.981880090609, 3636.8727094551564, 5156.303898973665, 5176.0, 5178.14560597501, 5211.400688920747, 5255.343082114736, 3575.481555174485, 3702.111922919277, 3702.777833329955, 3713.20166164276, 3731.626837316301, 3719.8326075326677, 3727.0682329417646, 3727.7763334200035, 3733.4959780429294, 3734.141147536082, 4223.788810559459, 4237.978810105929, 4242.278812601865, 4255.127698821734, 4261.637760790368, 4715.363425937455, 4937.23472861707, 4947.233178857283, 4966.279889416014, 4987.950120498748, 1238.9840330928553, 1258.8111783232405, 1261.88634037986, 1267.4359909840032, 1268.8413948256468, 794.2256300107349, 795.2047952047952, 805.589149533742, 824.9133840946735, 826.6032304493876, 4165.645920096765, 4383.561643835591, 4387.648988080946, 4413.867583972486, 4422.557744225552, 5132.07471741104, 5143.459936706667, 5144.276667316416, 5186.611004174702, 5188.844334669966, 4367.10474352757, 4368.301071828492, 4369.929367305031, 4383.846565370197, 4398.934015989763, 2593.572060610016, 2690.0, 2699.487097451478, 2711.227300219428, 2728.358835673615, 4816.579109162805, 4817.78319975602, 4823.382463152636, 4829.710217386968, 4839.0, 5067.974660126676, 5200.635955483155, 5216.426193118754, 5241.711705856138, 5302.469753024744, 4736.668433209642, 4802.447718512416, 4804.567588917014, 4827.493113223061, 4838.95161048385, 5098.694078355311, 5114.590832733298, 5116.667416617908, 5138.948610513847, 5172.5603323716405, 4885.0, 4975.601082640237, 5060.569851562658, 5064.164412871834, 5081.339425874613, 4791.544803243686, 4831.729087328949, 4832.395950506187, 4834.105690447279, 4835.347228124158, 3621.7464777465325, 3632.400653892078, 3632.654897784706, 3660.926781464409, 3666.7249956252854, 4990.850274491771, 5100.719460429564, 5126.179811230185, 5137.614678899172, 5140.665856719302, 4858.3441235432765, 4908.852734417973, 4937.0, 4944.579710724484, 4951.207806750903, 4943.184374578298, 4952.727599982036, 4956.132676781477, 4956.256561515802, 5019.874503137451, 4726.692764970266, 4901.411830580353, 4914.483979182134, 4929.13740095489, 4950.900981980412, 4776.904461910673, 4846.5460361892, 4951.0, 5004.724740139181, 5006.623178625907, 4877.341558889504, 4887.853364399074, 4926.48271931442, 4945.2582112683385, 4950.430700469492], "value": 3752.4673901081314, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.5565259097904, 581.1602234770756, 611.2298503885106, 624.3194917539886, 630.1241274628264, 11344.886551134487, 12292.0, 12298.38508074596, 12313.630591082281, 12379.257244565333, 11093.223474356779, 11952.641420757369, 12020.81968770467, 12042.397880106004, 12050.457729402176, 745.8060904164929, 761.9771406857775, 768.6080099149447, 769.8922150898878, 770.2336175505352, 755.735492577599, 757.0650246945019, 759.3735168485994, 762.8474305138967, 764.7361660227212, 799.5242830515833, 801.6512816924627, 802.1216767639426, 802.1497212954258, 806.762005208462, 797.9281864632181, 801.907780605232, 802.2619190344897, 803.1005274093023, 803.4175222963363, 582.6183849578533, 583.0903790087435, 583.5477504933668, 585.2654918077827, 585.809611876142, 11218.158638102175, 11297.49161287744, 11307.49116289769, 11316.547338106466, 11427.714307142305, 10728.624498142606, 10799.4060326682, 10818.0, 10924.2899211551, 11412.372319522423, 9532.428054316762, 9595.90404095964, 9703.417794932328, 9806.705798825975, 9908.35595686278, 3226.1439210900085, 3301.653326400741, 3336.96663033369, 3360.5631267935255, 3383.881564145268, 61691.383086169015, 62928.0, 62960.68519657418, 66006.0, 68000.3199967999, 7555.16893141754, 7584.582847943306, 7701.0, 7933.484323518953, 7971.202879712098, 16432.83567164337, 16491.83508164903, 16537.090460024574, 16547.420840270534, 16580.336786528405, 6467.644279564669, 6576.539642224999, 6659.2008958925235, 6830.521863469509, 7000.194977577542, 3733.4213196954515, 3775.811209439572, 3795.2409518096492, 3816.790076545761, 3825.923481530354, 2720.455908818244, 2821.6614006319373, 2830.278279038832, 2831.065748303055, 2841.872115754796, 471.11430510639775, 477.23642172524376, 478.8898553332753, 480.29156993434407, 492.1608657239398, 476.64251811141645, 501.3958180392618, 538.0691403871247, 538.8652836790802, 540.5108376918895, 7613.200613935568, 7840.67023151552, 7920.247576480225, 7951.284384405431, 8071.313938315191, 477.2483338741496, 501.208091215878, 503.3381103848501, 510.2142700241586, 524.9947500524946, 3716.108134047809, 3810.466534685146, 3838.961610383916, 3982.046607482509, 4033.556308806029, 103047.48476257571, 104909.0, 106148.46925765321, 110597.44701276442, 112438.0, 89689.0, 89872.5506372464, 91693.0, 91981.0, 94849.5257523708, 77540.61229693815, 79083.0, 79083.0, 79738.0, 81759.0, 7380.889286660812, 7411.962940185264, 7531.435142364235, 7648.847023059397, 7722.652480638272, 46420.53579464297, 48502.757486213755, 48974.26538601995, 49081.0, 49362.25956610582, 62966.370336297885, 63732.68133659302, 69368.30631693618, 69630.65184674044, 70463.64768176126, 9536.189423899046, 9900.0, 10139.84790228162, 10202.948985255027, 10208.897911021091, 11166.0, 11199.384033878216, 11206.327620342805, 11220.831687524531, 11280.492377842853, 10019.899801002188, 10070.446125462877, 10110.39337639744, 10301.0, 10472.214583906085, 9359.391639543408, 9363.4381937084, 9866.161376283097, 10277.383356998604, 10780.353178808982, 9521.476318802532, 9617.422954622745, 9692.321537492307, 10204.285700000928, 10819.242653014528, 9534.761630959281, 9709.56306966174, 9869.25980551476, 9930.900690992998, 10155.796884062425, 9984.500774961369, 10185.541650625888, 10259.538320775433, 10499.107575856138, 10518.894811051792], "value": 6220.086601788058, "unit": "score"}], "name": "dromaeo_css", "value": 6225.889332783368, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 113.0, 113.0, 115.0, 114.0, 113.0, 120.0, 113.0, 113.0, 112.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 126.0, 147.0, 184.0, 121.0, 148.0, 154.0, 122.0, 181.0, 124.0], "value": 146.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 169.0, 162.0, 163.0, 161.0, 162.0, 161.0, 161.0, 161.0, 160.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 119.0, 121.0, 77.0, 77.0, 76.0, 116.0, 105.0, 77.0], "value": 91.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 140.0, 87.0, 88.0, 86.0, 133.0, 88.0, 87.0, 144.0], "value": 103.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 117.0, 119.0, 118.0, 119.0, 118.0, 118.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 145.0, 146.0, 146.0, 147.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 65.0, 66.0, 66.0, 67.0, 67.0, 69.0, 73.0, 66.0, 66.0], "value": 67.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 67.0, 68.0, 67.0, 67.0, 66.0, 66.0, 66.0], "value": 66.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 82.0, 82.0, 85.0, 82.0, 87.0, 83.0, 87.0, 83.0], "value": 83.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 149.0, 133.0, 133.0, 134.0, 133.0, 140.0, 134.0, 149.0, 139.0], "value": 138.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 181.0, 177.0, 172.0, 176.0, 178.0, 171.0, 171.0, 169.0, 171.0], "value": 174.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 70.0, 70.0, 70.0, 67.0, 68.0, 72.0, 72.0, 67.0, 71.0], "value": 69.9, "unit": "score"}], "name": "kraken", "value": 1574.7, "alertThreshold": 2.0}]} 16:09:46 INFO - Return code: 0 16:09:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:09:46 INFO - # TBPL SUCCESS # 16:09:46 INFO - Running post-action listener: _resource_record_post_action 16:09:46 INFO - [mozharness: 2016-08-22 23:09:46.725739Z] Finished run-tests step (success) 16:09:46 INFO - Running post-run listener: _resource_record_post_run 16:09:46 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 418312192; Read time: 16; Write time: 269920 16:09:46 INFO - TinderboxPrint: CPU usage
13.2% 16:09:46 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 16:09:46 INFO - TinderboxPrint: I/O write bytes / time
418,312,192 / 269,920 16:09:46 INFO - TinderboxPrint: CPU idle
8,320.4 (86.7%) 16:09:46 INFO - TinderboxPrint: CPU user
1,206.2 (12.6%) 16:09:46 INFO - TinderboxPrint: Swap in / out
0 / 0 16:09:46 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 124669952; Read time: 0; Write time: 86628 16:09:46 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 292749312; Read time: 0; Write time: 183264 16:09:47 INFO - Running post-run listener: _upload_blobber_files 16:09:47 INFO - Blob upload gear active. 16:09:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:09:47 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 16:09:47 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'] 16:09:47 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 16:09:47 INFO - (blobuploader) - INFO - Open directory for files ... 16:09:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:09:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:09:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:09:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:09:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:09:48 INFO - (blobuploader) - INFO - Done attempting. 16:09:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:09:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:09:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:09:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:09:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:09:49 INFO - (blobuploader) - INFO - Done attempting. 16:09:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:09:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:09:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:09:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:09:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:09:52 INFO - (blobuploader) - INFO - Done attempting. 16:09:52 INFO - (blobuploader) - INFO - Iteration through files over. 16:09:52 INFO - Return code: 0 16:09:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:09:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:09:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b04fa852998442a66db777746bcfc0f54ee2ad42ea703b97a5617b8751b5b4cc38c6a42600e1cdb5cf79609558773c78d48c0337aa5fe451ec56d5e8d2520ab2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4d90dd0bf02db39dd9956c4ed8da0c375cafb4bd6290735b2f6e21dad92bc0d36dfc4516fbe1118ec48aa00bddfe677f8edc8a748b67ed9d244c8c42d84e4596", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/44b1dcdc93d151dbd3fe2ca701e8ebcbad8552e98708f80c54dd8ab992b626a2cf94e7286e98268472fb50f9c14492bf9e8e2a9d393d3e8dd735972824ff0858"} 16:09:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:09:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:09:52 INFO - Contents: 16:09:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b04fa852998442a66db777746bcfc0f54ee2ad42ea703b97a5617b8751b5b4cc38c6a42600e1cdb5cf79609558773c78d48c0337aa5fe451ec56d5e8d2520ab2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4d90dd0bf02db39dd9956c4ed8da0c375cafb4bd6290735b2f6e21dad92bc0d36dfc4516fbe1118ec48aa00bddfe677f8edc8a748b67ed9d244c8c42d84e4596", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/44b1dcdc93d151dbd3fe2ca701e8ebcbad8552e98708f80c54dd8ab992b626a2cf94e7286e98268472fb50f9c14492bf9e8e2a9d393d3e8dd735972824ff0858"} 16:09:52 INFO - Running post-run listener: copy_logs_to_upload_dir 16:09:52 INFO - Copying logs to upload dir... 16:09:52 INFO - mkdir: /builds/slave/test/build/upload/logs 16:09:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.471604 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-08-22 16:09:52.490817) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 16:09:52.494554) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1471906145.370864-1644060607 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/b04fa852998442a66db777746bcfc0f54ee2ad42ea703b97a5617b8751b5b4cc38c6a42600e1cdb5cf79609558773c78d48c0337aa5fe451ec56d5e8d2520ab2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4d90dd0bf02db39dd9956c4ed8da0c375cafb4bd6290735b2f6e21dad92bc0d36dfc4516fbe1118ec48aa00bddfe677f8edc8a748b67ed9d244c8c42d84e4596", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/44b1dcdc93d151dbd3fe2ca701e8ebcbad8552e98708f80c54dd8ab992b626a2cf94e7286e98268472fb50f9c14492bf9e8e2a9d393d3e8dd735972824ff0858"} build_url:https://queue.taskcluster.net/v1/task/T4J-7ohwSdGP-I9a6YvoMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011447 build_url: 'https://queue.taskcluster.net/v1/task/T4J-7ohwSdGP-I9a6YvoMg/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/b04fa852998442a66db777746bcfc0f54ee2ad42ea703b97a5617b8751b5b4cc38c6a42600e1cdb5cf79609558773c78d48c0337aa5fe451ec56d5e8d2520ab2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4d90dd0bf02db39dd9956c4ed8da0c375cafb4bd6290735b2f6e21dad92bc0d36dfc4516fbe1118ec48aa00bddfe677f8edc8a748b67ed9d244c8c42d84e4596", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/44b1dcdc93d151dbd3fe2ca701e8ebcbad8552e98708f80c54dd8ab992b626a2cf94e7286e98268472fb50f9c14492bf9e8e2a9d393d3e8dd735972824ff0858"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 16:09:52.520177) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 16:09:52.520530) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1471906145.370864-1644060607 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004443 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 16:09:52.605329) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 16:09:52.605713) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 16:09:52.606077) ========= ========= Total master_lag: 0.16 =========