builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-036 starttime: 1472156486.31 results: success (0) buildid: 20160825123516 builduid: f90bde4f0ff24389bde3d45934b64762 revision: 4988e9ed22f34ffa92723a16b0be9f82f48fe3e9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-25 13:21:26.314565) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-25 13:21:26.315086) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-25 13:21:26.315399) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-25 13:21:26.327259) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 13:21:26.327574) ========= 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=14ef55db36f7623abb31b9cf000001d5-1472156485.619106-482549871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-25 13:21:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.8M=0s 2016-08-25 13:21:26 (45.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.090071 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 13:21:26.429370) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 13:21:26.429731) ========= 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=14ef55db36f7623abb31b9cf000001d5-1472156485.619106-482549871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016724 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 13:21:26.478995) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 13:21:26.479358) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4988e9ed22f34ffa92723a16b0be9f82f48fe3e9 --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 4988e9ed22f34ffa92723a16b0be9f82f48fe3e9 --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=14ef55db36f7623abb31b9cf000001d5-1472156485.619106-482549871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-25 13:21:26,862 truncating revision to first 12 chars 2016-08-25 13:21:26,862 Setting DEBUG logging. 2016-08-25 13:21:26,862 attempt 1/10 2016-08-25 13:21:26,862 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4988e9ed22f3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-25 13:21:27,320 unpacking tar archive at: fx-team-4988e9ed22f3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.739827 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 13:21:27.233058) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-25 13:21:27.233382) ========= script_repo_revision: 4988e9ed22f34ffa92723a16b0be9f82f48fe3e9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-25 13:21:27.233787) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-25 13:21:27.234080) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-25 13:21:27.245399) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-08-25 13:21:27.246111) ========= /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=14ef55db36f7623abb31b9cf000001d5-1472156485.619106-482549871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:21:27 INFO - MultiFileLogger online at 20160825 13:21:27 in /builds/slave/test 13:21:27 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 13:21:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:21:27 INFO - {'append_to_log': False, 13:21:27 INFO - 'base_work_dir': '/builds/slave/test', 13:21:27 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 13:21:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:21:27 INFO - 'branch': 'Fx-Team-Non-PGO', 13:21:27 INFO - 'buildbot_json_path': 'buildprops.json', 13:21:27 INFO - 'config_files': ('talos/linux_config.py',), 13:21:27 INFO - 'default_actions': ('clobber', 13:21:27 INFO - 'read-buildbot-config', 13:21:27 INFO - 'download-and-extract', 13:21:27 INFO - 'populate-webroot', 13:21:27 INFO - 'create-virtualenv', 13:21:27 INFO - 'install', 13:21:27 INFO - 'run-tests'), 13:21:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:21:27 INFO - 'download_minidump_stackwalk': True, 13:21:27 INFO - 'download_symbols': 'ondemand', 13:21:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:21:27 INFO - 'tooltool.py': '/tools/tooltool.py', 13:21:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:21:27 INFO - '/tools/misc-python/virtualenv.py')}, 13:21:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:21:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:21:27 INFO - 'installer_path': 'installer.exe', 13:21:27 INFO - 'log_level': 'info', 13:21:27 INFO - 'log_name': 'talos', 13:21:27 INFO - 'log_to_console': True, 13:21:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:21:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:21:27 INFO - 'opt_config_files': (), 13:21:27 INFO - 'pip_index': False, 13:21:27 INFO - 'sps_profile': False, 13:21:27 INFO - 'sps_profile_interval': 0, 13:21:27 INFO - 'suite': 'dromaeojs', 13:21:27 INFO - 'system_bits': '32', 13:21:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:21:27 INFO - 'title': 'talos-linux64-ix-036', 13:21:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:21:27 INFO - 'use_talos_json': True, 13:21:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:21:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:21:27 INFO - 'work_dir': 'build'} 13:21:27 INFO - [mozharness: 2016-08-25 20:21:27.730494Z] Running clobber step. 13:21:27 INFO - Running pre-action listener: _resource_record_pre_action 13:21:27 INFO - Running main action method: clobber 13:21:27 INFO - rmtree: /builds/slave/test/build 13:21:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:21:28 INFO - Running post-action listener: _resource_record_post_action 13:21:28 INFO - [mozharness: 2016-08-25 20:21:28.214376Z] Finished clobber step (success) 13:21:28 INFO - [mozharness: 2016-08-25 20:21:28.214478Z] Running read-buildbot-config step. 13:21:28 INFO - Running pre-action listener: _resource_record_pre_action 13:21:28 INFO - Running main action method: read_buildbot_config 13:21:28 INFO - Using buildbot properties: 13:21:28 INFO - { 13:21:28 INFO - "project": "", 13:21:28 INFO - "product": "firefox", 13:21:28 INFO - "script_repo_revision": "production", 13:21:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:21:28 INFO - "repository": "", 13:21:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 13:21:28 INFO - "buildid": "20160825123516", 13:21:28 INFO - "pgo_build": "False", 13:21:28 INFO - "basedir": "/builds/slave/test", 13:21:28 INFO - "buildnumber": 2120, 13:21:28 INFO - "slavename": "talos-linux64-ix-036", 13:21:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:21:28 INFO - "platform": "ubuntu64_hw", 13:21:28 INFO - "scheduler": "tests-fx-team-linux64-talos", 13:21:28 INFO - "branch": "fx-team", 13:21:28 INFO - "repo_path": "integration/fx-team", 13:21:28 INFO - "revision": "4988e9ed22f34ffa92723a16b0be9f82f48fe3e9", 13:21:28 INFO - "stage_platform": "linux64", 13:21:28 INFO - "builduid": "f90bde4f0ff24389bde3d45934b64762", 13:21:28 INFO - "slavebuilddir": "test" 13:21:28 INFO - } 13:21:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/PmjOhxdCQ1OTV7Z3BPuKtw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 13:21:28 INFO - Running post-action listener: _resource_record_post_action 13:21:28 INFO - [mozharness: 2016-08-25 20:21:28.216894Z] Finished read-buildbot-config step (success) 13:21:28 INFO - [mozharness: 2016-08-25 20:21:28.216983Z] Running download-and-extract step. 13:21:28 INFO - Running pre-action listener: _resource_record_pre_action 13:21:28 INFO - Running main action method: download_and_extract 13:21:28 INFO - mkdir: /builds/slave/test/build/tests 13:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:21:28 INFO - trying https://queue.taskcluster.net/v1/task/PmjOhxdCQ1OTV7Z3BPuKtw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 13:21:28 INFO - Downloading https://queue.taskcluster.net/v1/task/PmjOhxdCQ1OTV7Z3BPuKtw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 13:21:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PmjOhxdCQ1OTV7Z3BPuKtw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:21:28 INFO - Downloaded 1361 bytes. 13:21:28 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 13:21:28 INFO - Using the following test package requirements: 13:21:28 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 13:21:28 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:21:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:21:28 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:21:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:21:28 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:21:28 INFO - u'jsshell-linux-x86_64.zip'], 13:21:28 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:21:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:21:28 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 13:21:28 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:21:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:21:28 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:21:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:21:28 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:21:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:21:28 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:21:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:21:28 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:21:28 INFO - trying https://queue.taskcluster.net/v1/task/PmjOhxdCQ1OTV7Z3BPuKtw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 13:21:28 INFO - Downloading https://queue.taskcluster.net/v1/task/PmjOhxdCQ1OTV7Z3BPuKtw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 13:21:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PmjOhxdCQ1OTV7Z3BPuKtw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:21:29 INFO - Downloaded 20324517 bytes. 13:21:29 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 13:21:33 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:21:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:21:33 INFO - trying https://queue.taskcluster.net/v1/task/PmjOhxdCQ1OTV7Z3BPuKtw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 13:21:33 INFO - Downloading https://queue.taskcluster.net/v1/task/PmjOhxdCQ1OTV7Z3BPuKtw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 13:21:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PmjOhxdCQ1OTV7Z3BPuKtw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:21:34 INFO - Downloaded 20324517 bytes. 13:21:34 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 13:21: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')]} 13:21:39 INFO - trying https://queue.taskcluster.net/v1/task/PmjOhxdCQ1OTV7Z3BPuKtw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 13:21:39 INFO - Downloading https://queue.taskcluster.net/v1/task/PmjOhxdCQ1OTV7Z3BPuKtw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 13:21:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PmjOhxdCQ1OTV7Z3BPuKtw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:21:40 INFO - Downloaded 14413981 bytes. 13:21:40 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 13:21:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:21:40 INFO - trying https://queue.taskcluster.net/v1/task/PmjOhxdCQ1OTV7Z3BPuKtw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 13:21:40 INFO - Downloading https://queue.taskcluster.net/v1/task/PmjOhxdCQ1OTV7Z3BPuKtw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 13:21:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PmjOhxdCQ1OTV7Z3BPuKtw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:21:41 INFO - Downloaded 55751140 bytes. 13:21:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PmjOhxdCQ1OTV7Z3BPuKtw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 13:21:41 INFO - mkdir: /builds/slave/test/properties 13:21:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:21:41 INFO - Writing to file /builds/slave/test/properties/build_url 13:21:41 INFO - Contents: 13:21:41 INFO - build_url:https://queue.taskcluster.net/v1/task/PmjOhxdCQ1OTV7Z3BPuKtw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 13:21:42 INFO - Running post-action listener: _resource_record_post_action 13:21:42 INFO - Running post-action listener: set_extra_try_arguments 13:21:42 INFO - [mozharness: 2016-08-25 20:21:42.242773Z] Finished download-and-extract step (success) 13:21:42 INFO - [mozharness: 2016-08-25 20:21:42.242999Z] Running populate-webroot step. 13:21:42 INFO - Running pre-action listener: _resource_record_pre_action 13:21:42 INFO - Running main action method: populate_webroot 13:21:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:21:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:21:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:21:42 INFO - '--tppagecycles', 13:21:42 INFO - '7'], 13:21:42 INFO - 'tests': ['tsvgm']}}, 13:21:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:21:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:21:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:21:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:21:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:21:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:21:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:42 INFO - 'talos_options': ['--disable-e10s'], 13:21:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:21:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:21:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:42 INFO - 'talos_options': ['--disable-e10s'], 13:21:42 INFO - 'tests': ['damp', 'tps']}, 13:21:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:42 INFO - 'tests': ['damp', 'tps']}, 13:21:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:21:42 INFO - 'tests': ['dromaeo_dom']}, 13:21:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:21:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:21:42 INFO - 'tests': ['basic_compositor_video']}, 13:21:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:21:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:21:42 INFO - 'tests': ['a11yr', 13:21:42 INFO - 'ts_paint', 13:21:42 INFO - 'tpaint', 13:21:42 INFO - 'sessionrestore', 13:21:42 INFO - 'sessionrestore_no_auto_restore', 13:21:42 INFO - 'tabpaint']}, 13:21:42 INFO - 'other-e10s': {'tests': ['a11yr', 13:21:42 INFO - 'ts_paint', 13:21:42 INFO - 'tpaint', 13:21:42 INFO - 'sessionrestore', 13:21:42 INFO - 'sessionrestore_no_auto_restore', 13:21:42 INFO - 'tabpaint']}, 13:21:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:21:42 INFO - 'ts_paint', 13:21:42 INFO - 'tpaint', 13:21:42 INFO - 'sessionrestore', 13:21:42 INFO - 'sessionrestore_no_auto_restore', 13:21:42 INFO - 'tabpaint']}, 13:21:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:21:42 INFO - 'ts_paint', 13:21:42 INFO - 'tpaint', 13:21:42 INFO - 'sessionrestore', 13:21:42 INFO - 'sessionrestore_no_auto_restore', 13:21:42 INFO - 'tabpaint']}, 13:21:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:21:42 INFO - 'tests': ['a11yr', 13:21:42 INFO - 'ts_paint', 13:21:42 INFO - 'tpaint', 13:21:42 INFO - 'sessionrestore', 13:21:42 INFO - 'sessionrestore_no_auto_restore', 13:21:42 INFO - 'tabpaint']}, 13:21:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:21:42 INFO - 'tests': ['a11yr', 13:21:42 INFO - 'ts_paint', 13:21:42 INFO - 'tpaint', 13:21:42 INFO - 'sessionrestore', 13:21:42 INFO - 'sessionrestore_no_auto_restore', 13:21:42 INFO - 'tabpaint']}, 13:21:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:21:42 INFO - 'tests': ['tsvgx', 13:21:42 INFO - 'tsvgr_opacity', 13:21:42 INFO - 'tart', 13:21:42 INFO - 'tscrollx', 13:21:42 INFO - 'cart']}, 13:21:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:21:42 INFO - 'tsvgr_opacity', 13:21:42 INFO - 'tart', 13:21:42 INFO - 'tscrollx', 13:21:42 INFO - 'cart']}, 13:21:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:42 INFO - 'talos_options': ['--disable-e10s'], 13:21:42 INFO - 'tests': ['tp5o']}, 13:21:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:42 INFO - 'tests': ['tp5o']}, 13:21:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:42 INFO - 'talos_options': ['--disable-e10s', 13:21:42 INFO - '--xperf_path', 13:21:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:21:42 INFO - 'tests': ['tp5n']}, 13:21:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:21:42 INFO - 'talos_options': ['--xperf_path', 13:21:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:21:42 INFO - 'tests': ['tp5n']}}, 13:21:42 INFO - 'talos.zip': {'path': '', 13:21:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:21:42 INFO - Running post-action listener: _resource_record_post_action 13:21:42 INFO - [mozharness: 2016-08-25 20:21:42.260308Z] Finished populate-webroot step (success) 13:21:42 INFO - [mozharness: 2016-08-25 20:21:42.260396Z] Running create-virtualenv step. 13:21:42 INFO - Running pre-action listener: _resource_record_pre_action 13:21:42 INFO - Running main action method: create_virtualenv 13:21:42 INFO - Creating virtualenv /builds/slave/test/build/venv 13:21:42 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:21:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:21:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:21:42 INFO - Using real prefix '/usr' 13:21:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:21:42 INFO - Installing distribute.............................................................................................................................................................................................done. 13:21:44 INFO - Installing pip.................done. 13:21:44 INFO - Return code: 0 13:21:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:21: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')]} 13:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21: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')]} 13:21:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd3284ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a73230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6d090>, '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 0x1a709b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a70e40>, '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': '14ef55db36f7623abb31b9cf000001d5-1472156485.619106-482549871', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:21: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', 'pip>=1.5'] in /builds/slave/test/build 13:21: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 pip>=1.5 13:21:44 INFO - Using env: {'DISPLAY': ':0', 13:21:44 INFO - 'HOME': '/home/cltbld', 13:21:44 INFO - 'LANG': 'en_US.UTF-8', 13:21:44 INFO - 'LANGUAGE': 'en_US:en', 13:21:44 INFO - 'LOGNAME': 'cltbld', 13:21:44 INFO - 'MAIL': '/var/mail/cltbld', 13:21:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:44 INFO - 'MOZ_NO_REMOTE': '1', 13:21:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:21:44 INFO - 'NO_EM_RESTART': '1', 13:21:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:21:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:21:44 INFO - 'PWD': '/builds/slave/test', 13:21:44 INFO - 'SHELL': '/bin/bash', 13:21:44 INFO - 'SHLVL': '1', 13:21:44 INFO - 'TERM': 'linux', 13:21:44 INFO - 'TMOUT': '86400', 13:21:44 INFO - 'USER': 'cltbld', 13:21:44 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1472156485.619106-482549871', 13:21:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:44 INFO - '_': '/tools/buildbot/bin/python'} 13:21:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:45 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:21:45 INFO - Cleaning up... 13:21:45 INFO - Return code: 0 13:21:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:21:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:21:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:45 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 0x7fcd3284ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a73230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6d090>, '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 0x1a709b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a70e40>, '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': '14ef55db36f7623abb31b9cf000001d5-1472156485.619106-482549871', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:21:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:21:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:21:45 INFO - Using env: {'DISPLAY': ':0', 13:21:45 INFO - 'HOME': '/home/cltbld', 13:21:45 INFO - 'LANG': 'en_US.UTF-8', 13:21:45 INFO - 'LANGUAGE': 'en_US:en', 13:21:45 INFO - 'LOGNAME': 'cltbld', 13:21:45 INFO - 'MAIL': '/var/mail/cltbld', 13:21:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:45 INFO - 'MOZ_NO_REMOTE': '1', 13:21:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:21:45 INFO - 'NO_EM_RESTART': '1', 13:21:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:21:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:21:45 INFO - 'PWD': '/builds/slave/test', 13:21:45 INFO - 'SHELL': '/bin/bash', 13:21:45 INFO - 'SHLVL': '1', 13:21:45 INFO - 'TERM': 'linux', 13:21:45 INFO - 'TMOUT': '86400', 13:21:45 INFO - 'USER': 'cltbld', 13:21:45 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1472156485.619106-482549871', 13:21:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:45 INFO - '_': '/tools/buildbot/bin/python'} 13:21:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:45 INFO - Downloading/unpacking psutil>=3.1.1 13:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:21:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:21:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:21:47 INFO - Installing collected packages: psutil 13:21:47 INFO - Running setup.py install for psutil 13:21:47 INFO - building 'psutil._psutil_linux' extension 13:21:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 13:21:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 13:21:47 INFO - building 'psutil._psutil_posix' extension 13:21:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 13:21:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 13:21:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:21:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:21:47 INFO - Successfully installed psutil 13:21:47 INFO - Cleaning up... 13:21:47 INFO - Return code: 0 13:21:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:21:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:47 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 0x7fcd3284ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a73230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6d090>, '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 0x1a709b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a70e40>, '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': '14ef55db36f7623abb31b9cf000001d5-1472156485.619106-482549871', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:21:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:21:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:21:47 INFO - Using env: {'DISPLAY': ':0', 13:21:47 INFO - 'HOME': '/home/cltbld', 13:21:47 INFO - 'LANG': 'en_US.UTF-8', 13:21:47 INFO - 'LANGUAGE': 'en_US:en', 13:21:47 INFO - 'LOGNAME': 'cltbld', 13:21:47 INFO - 'MAIL': '/var/mail/cltbld', 13:21:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:47 INFO - 'MOZ_NO_REMOTE': '1', 13:21:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:21:47 INFO - 'NO_EM_RESTART': '1', 13:21:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:21:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:21:47 INFO - 'PWD': '/builds/slave/test', 13:21:47 INFO - 'SHELL': '/bin/bash', 13:21:47 INFO - 'SHLVL': '1', 13:21:47 INFO - 'TERM': 'linux', 13:21:47 INFO - 'TMOUT': '86400', 13:21:47 INFO - 'USER': 'cltbld', 13:21:47 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1472156485.619106-482549871', 13:21:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:47 INFO - '_': '/tools/buildbot/bin/python'} 13:21:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:21:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:21:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:21:49 INFO - Installing collected packages: mozsystemmonitor 13:21:49 INFO - Running setup.py install for mozsystemmonitor 13:21:50 INFO - Successfully installed mozsystemmonitor 13:21:50 INFO - Cleaning up... 13:21:50 INFO - Return code: 0 13:21:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:21:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:21:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:50 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 0x7fcd3284ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a73230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6d090>, '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 0x1a709b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a70e40>, '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': '14ef55db36f7623abb31b9cf000001d5-1472156485.619106-482549871', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:21:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:21:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:21:50 INFO - Using env: {'DISPLAY': ':0', 13:21:50 INFO - 'HOME': '/home/cltbld', 13:21:50 INFO - 'LANG': 'en_US.UTF-8', 13:21:50 INFO - 'LANGUAGE': 'en_US:en', 13:21:50 INFO - 'LOGNAME': 'cltbld', 13:21:50 INFO - 'MAIL': '/var/mail/cltbld', 13:21:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:50 INFO - 'MOZ_NO_REMOTE': '1', 13:21:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:21:50 INFO - 'NO_EM_RESTART': '1', 13:21:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:21:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:21:50 INFO - 'PWD': '/builds/slave/test', 13:21:50 INFO - 'SHELL': '/bin/bash', 13:21:50 INFO - 'SHLVL': '1', 13:21:50 INFO - 'TERM': 'linux', 13:21:50 INFO - 'TMOUT': '86400', 13:21:50 INFO - 'USER': 'cltbld', 13:21:50 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1472156485.619106-482549871', 13:21:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:50 INFO - '_': '/tools/buildbot/bin/python'} 13:21:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:50 INFO - Downloading/unpacking jsonschema==2.5.1 13:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:21:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:52 INFO - Downloading functools32-3.2.3-2.tar.gz 13:21:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:21:52 INFO - warning: no files found matching '*.txt' 13:21:52 INFO - no previously-included directories found matching 'build' 13:21:52 INFO - no previously-included directories found matching 'dist' 13:21:52 INFO - no previously-included directories found matching '.git*' 13:21:52 INFO - Installing collected packages: jsonschema, functools32 13:21:52 INFO - Running setup.py install for functools32 13:21:52 INFO - warning: no files found matching '*.txt' 13:21:52 INFO - no previously-included directories found matching 'build' 13:21:52 INFO - no previously-included directories found matching 'dist' 13:21:52 INFO - no previously-included directories found matching '.git*' 13:21:52 INFO - Successfully installed jsonschema functools32 13:21:52 INFO - Cleaning up... 13:21:52 INFO - Return code: 0 13:21:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:21:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:52 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 0x7fcd3284ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a73230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6d090>, '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 0x1a709b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a70e40>, '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': '14ef55db36f7623abb31b9cf000001d5-1472156485.619106-482549871', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:21:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:21:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:21:52 INFO - Using env: {'DISPLAY': ':0', 13:21:52 INFO - 'HOME': '/home/cltbld', 13:21:52 INFO - 'LANG': 'en_US.UTF-8', 13:21:52 INFO - 'LANGUAGE': 'en_US:en', 13:21:52 INFO - 'LOGNAME': 'cltbld', 13:21:52 INFO - 'MAIL': '/var/mail/cltbld', 13:21:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:52 INFO - 'MOZ_NO_REMOTE': '1', 13:21:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:21:52 INFO - 'NO_EM_RESTART': '1', 13:21:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:21:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:21:52 INFO - 'PWD': '/builds/slave/test', 13:21:52 INFO - 'SHELL': '/bin/bash', 13:21:52 INFO - 'SHLVL': '1', 13:21:52 INFO - 'TERM': 'linux', 13:21:52 INFO - 'TMOUT': '86400', 13:21:52 INFO - 'USER': 'cltbld', 13:21:52 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1472156485.619106-482549871', 13:21:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:52 INFO - '_': '/tools/buildbot/bin/python'} 13:21:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:21:52 INFO - Cleaning up... 13:21:52 INFO - Return code: 0 13:21:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:21:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:52 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 0x7fcd3284ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a73230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6d090>, '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 0x1a709b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a70e40>, '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': '14ef55db36f7623abb31b9cf000001d5-1472156485.619106-482549871', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:21:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:21:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:21:52 INFO - Using env: {'DISPLAY': ':0', 13:21:52 INFO - 'HOME': '/home/cltbld', 13:21:52 INFO - 'LANG': 'en_US.UTF-8', 13:21:52 INFO - 'LANGUAGE': 'en_US:en', 13:21:52 INFO - 'LOGNAME': 'cltbld', 13:21:52 INFO - 'MAIL': '/var/mail/cltbld', 13:21:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:52 INFO - 'MOZ_NO_REMOTE': '1', 13:21:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:21:52 INFO - 'NO_EM_RESTART': '1', 13:21:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:21:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:21:52 INFO - 'PWD': '/builds/slave/test', 13:21:52 INFO - 'SHELL': '/bin/bash', 13:21:52 INFO - 'SHLVL': '1', 13:21:52 INFO - 'TERM': 'linux', 13:21:52 INFO - 'TMOUT': '86400', 13:21:52 INFO - 'USER': 'cltbld', 13:21:52 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1472156485.619106-482549871', 13:21:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:52 INFO - '_': '/tools/buildbot/bin/python'} 13:21:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:53 INFO - Downloading/unpacking blobuploader==1.2.4 13:21:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:54 INFO - Downloading blobuploader-1.2.4.tar.gz 13:21:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:21:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:21:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:21:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:21:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:21:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:21:55 INFO - Downloading docopt-0.6.1.tar.gz 13:21:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:21:55 INFO - Installing collected packages: blobuploader, requests, docopt 13:21:55 INFO - Running setup.py install for blobuploader 13:21:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:21:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:21:55 INFO - Running setup.py install for requests 13:21:56 INFO - Running setup.py install for docopt 13:21:56 INFO - Successfully installed blobuploader requests docopt 13:21:56 INFO - Cleaning up... 13:21:56 INFO - Return code: 0 13:21:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:21:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:21:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:56 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 0x7fcd3284ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a73230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6d090>, '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 0x1a709b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a70e40>, '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': '14ef55db36f7623abb31b9cf000001d5-1472156485.619106-482549871', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:21:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:21:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:21:56 INFO - Using env: {'DISPLAY': ':0', 13:21:56 INFO - 'HOME': '/home/cltbld', 13:21:56 INFO - 'LANG': 'en_US.UTF-8', 13:21:56 INFO - 'LANGUAGE': 'en_US:en', 13:21:56 INFO - 'LOGNAME': 'cltbld', 13:21:56 INFO - 'MAIL': '/var/mail/cltbld', 13:21:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:56 INFO - 'MOZ_NO_REMOTE': '1', 13:21:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:21:56 INFO - 'NO_EM_RESTART': '1', 13:21:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:21:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:21:56 INFO - 'PWD': '/builds/slave/test', 13:21:56 INFO - 'SHELL': '/bin/bash', 13:21:56 INFO - 'SHLVL': '1', 13:21:56 INFO - 'TERM': 'linux', 13:21:56 INFO - 'TMOUT': '86400', 13:21:56 INFO - 'USER': 'cltbld', 13:21:56 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1472156485.619106-482549871', 13:21:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:56 INFO - '_': '/tools/buildbot/bin/python'} 13:21:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:21:56 INFO - Running setup.py (path:/tmp/pip-_XHzEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:21:56 INFO - Running setup.py (path:/tmp/pip-M7yL_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:21:56 INFO - Running setup.py (path:/tmp/pip-2OMhJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:21:56 INFO - Running setup.py (path:/tmp/pip-JeRcDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:21:56 INFO - Running setup.py (path:/tmp/pip-fjLRNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:21:56 INFO - Running setup.py (path:/tmp/pip-YP5cN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:21:56 INFO - Running setup.py (path:/tmp/pip-ONa2qC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:21:57 INFO - Running setup.py (path:/tmp/pip-lymyvv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:21:57 INFO - Running setup.py (path:/tmp/pip-Crgt27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:21:57 INFO - Running setup.py (path:/tmp/pip-pp2UuG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:21:57 INFO - Running setup.py (path:/tmp/pip-uSUWqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:21:57 INFO - Running setup.py (path:/tmp/pip-XfbWWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:21:57 INFO - Running setup.py (path:/tmp/pip-0J14z2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:21:57 INFO - Running setup.py (path:/tmp/pip-tle5lL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:21:57 INFO - Running setup.py (path:/tmp/pip-0NEpWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:21:57 INFO - Running setup.py (path:/tmp/pip-mwx1hy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:21:57 INFO - Running setup.py (path:/tmp/pip-hUabf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:21:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:21:57 INFO - Running setup.py install for manifestparser 13:21:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:21:57 INFO - Running setup.py install for mozcrash 13:21:57 INFO - Running setup.py install for mozdebug 13:21:58 INFO - Running setup.py install for mozdevice 13:21:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:21:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:21:58 INFO - Running setup.py install for mozfile 13:21:58 INFO - Running setup.py install for mozhttpd 13:21:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:21:58 INFO - Running setup.py install for mozinfo 13:21:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:21:58 INFO - Running setup.py install for mozInstall 13:21:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:21:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:21:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:21:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:21:58 INFO - Running setup.py install for mozleak 13:21:58 INFO - Running setup.py install for mozlog 13:21:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:21:58 INFO - Running setup.py install for moznetwork 13:21:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:21:58 INFO - Running setup.py install for mozprocess 13:21:58 INFO - Running setup.py install for mozprofile 13:21:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:21:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:21:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:21:59 INFO - Running setup.py install for mozrunner 13:21:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:21:59 INFO - Running setup.py install for mozscreenshot 13:21:59 INFO - Running setup.py install for moztest 13:21:59 INFO - Running setup.py install for mozversion 13:21:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:21:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:21:59 INFO - Cleaning up... 13:21:59 INFO - Return code: 0 13:21:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:21:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:21:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:21:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:21:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:21:59 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 0x7fcd3284ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a73230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6d090>, '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 0x1a709b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a70e40>, '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': '14ef55db36f7623abb31b9cf000001d5-1472156485.619106-482549871', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:21:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:21:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:21:59 INFO - Using env: {'DISPLAY': ':0', 13:21:59 INFO - 'HOME': '/home/cltbld', 13:21:59 INFO - 'LANG': 'en_US.UTF-8', 13:21:59 INFO - 'LANGUAGE': 'en_US:en', 13:21:59 INFO - 'LOGNAME': 'cltbld', 13:21:59 INFO - 'MAIL': '/var/mail/cltbld', 13:21:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:21:59 INFO - 'MOZ_NO_REMOTE': '1', 13:21:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:21:59 INFO - 'NO_EM_RESTART': '1', 13:21:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:21:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:21:59 INFO - 'PWD': '/builds/slave/test', 13:21:59 INFO - 'SHELL': '/bin/bash', 13:21:59 INFO - 'SHLVL': '1', 13:21:59 INFO - 'TERM': 'linux', 13:21:59 INFO - 'TMOUT': '86400', 13:21:59 INFO - 'USER': 'cltbld', 13:21:59 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1472156485.619106-482549871', 13:21:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:21:59 INFO - '_': '/tools/buildbot/bin/python'} 13:21:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:21:59 INFO - Running setup.py (path:/tmp/pip-F7Rp2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:21:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:21:59 INFO - Running setup.py (path:/tmp/pip-zirsBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:21:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:21:59 INFO - Running setup.py (path:/tmp/pip-ddtCT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:21:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:22:00 INFO - Running setup.py (path:/tmp/pip-nVvx3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:22:00 INFO - Running setup.py (path:/tmp/pip-uy66t8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:22:00 INFO - Running setup.py (path:/tmp/pip-aPlgg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:22:00 INFO - Running setup.py (path:/tmp/pip-mUVVMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:22:00 INFO - Running setup.py (path:/tmp/pip-VlJO7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:22:00 INFO - Running setup.py (path:/tmp/pip-k7Y1sI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:22:00 INFO - Running setup.py (path:/tmp/pip-BigsCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:22:00 INFO - Running setup.py (path:/tmp/pip-dtQFNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:22:00 INFO - Running setup.py (path:/tmp/pip-a54Xyr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:22:00 INFO - Running setup.py (path:/tmp/pip-4dNdfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:22:00 INFO - Running setup.py (path:/tmp/pip-U7U5iz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:22:00 INFO - Running setup.py (path:/tmp/pip-UutG3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:22:00 INFO - Running setup.py (path:/tmp/pip-rGoaqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:22:00 INFO - Running setup.py (path:/tmp/pip-KJTMHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:22:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:22:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:22:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:22:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:22:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:22:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:22:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:22:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:22:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:22:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:22:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:22:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:22:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:22:02 INFO - Downloading blessings-1.6.tar.gz 13:22:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:22:02 INFO - Installing collected packages: blessings 13:22:02 INFO - Running setup.py install for blessings 13:22:03 INFO - Successfully installed blessings 13:22:03 INFO - Cleaning up... 13:22:03 INFO - Return code: 0 13:22:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:22:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:22:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:22:03 INFO - Reading from file tmpfile_stdout 13:22:03 INFO - Current package versions: 13:22:03 INFO - argparse == 1.2.1 13:22:03 INFO - blessings == 1.6 13:22:03 INFO - blobuploader == 1.2.4 13:22:03 INFO - docopt == 0.6.1 13:22:03 INFO - functools32 == 3.2.3-2 13:22:03 INFO - jsonschema == 2.5.1 13:22:03 INFO - manifestparser == 1.1 13:22:03 INFO - mozInstall == 1.12 13:22:03 INFO - mozcrash == 0.17 13:22:03 INFO - mozdebug == 0.1 13:22:03 INFO - mozdevice == 0.48 13:22:03 INFO - mozfile == 1.2 13:22:03 INFO - mozhttpd == 0.7 13:22:03 INFO - mozinfo == 0.9 13:22:03 INFO - mozleak == 0.1 13:22:03 INFO - mozlog == 3.3 13:22:03 INFO - moznetwork == 0.27 13:22:03 INFO - mozprocess == 0.23 13:22:03 INFO - mozprofile == 0.28 13:22:03 INFO - mozrunner == 6.12 13:22:03 INFO - mozscreenshot == 0.1 13:22:03 INFO - mozsystemmonitor == 0.3 13:22:03 INFO - moztest == 0.7 13:22:03 INFO - mozversion == 1.4 13:22:03 INFO - psutil == 3.1.1 13:22:03 INFO - requests == 1.2.3 13:22:03 INFO - wsgiref == 0.1.2 13:22:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:22:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:22:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:22:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:22:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:03 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 0x7fcd3284ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a73230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6d090>, '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 0x1a709b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a70e40>, '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': '14ef55db36f7623abb31b9cf000001d5-1472156485.619106-482549871', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:22:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:22:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:22:03 INFO - Using env: {'DISPLAY': ':0', 13:22:03 INFO - 'HOME': '/home/cltbld', 13:22:03 INFO - 'LANG': 'en_US.UTF-8', 13:22:03 INFO - 'LANGUAGE': 'en_US:en', 13:22:03 INFO - 'LOGNAME': 'cltbld', 13:22:03 INFO - 'MAIL': '/var/mail/cltbld', 13:22:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:22:03 INFO - 'MOZ_NO_REMOTE': '1', 13:22:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:22:03 INFO - 'NO_EM_RESTART': '1', 13:22:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:22:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:22:03 INFO - 'PWD': '/builds/slave/test', 13:22:03 INFO - 'SHELL': '/bin/bash', 13:22:03 INFO - 'SHLVL': '1', 13:22:03 INFO - 'TERM': 'linux', 13:22:03 INFO - 'TMOUT': '86400', 13:22:03 INFO - 'USER': 'cltbld', 13:22:03 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1472156485.619106-482549871', 13:22:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:22:03 INFO - '_': '/tools/buildbot/bin/python'} 13:22:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:22:03 INFO - Cleaning up... 13:22:03 INFO - Return code: 0 13:22:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:22:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:22:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:22:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:22:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:22:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd3284ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a73230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6d090>, '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 0x1a709b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a70e40>, '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': '14ef55db36f7623abb31b9cf000001d5-1472156485.619106-482549871', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:22:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:22:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:22:03 INFO - Using env: {'DISPLAY': ':0', 13:22:03 INFO - 'HOME': '/home/cltbld', 13:22:03 INFO - 'LANG': 'en_US.UTF-8', 13:22:03 INFO - 'LANGUAGE': 'en_US:en', 13:22:03 INFO - 'LOGNAME': 'cltbld', 13:22:03 INFO - 'MAIL': '/var/mail/cltbld', 13:22:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:22:03 INFO - 'MOZ_NO_REMOTE': '1', 13:22:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:22:03 INFO - 'NO_EM_RESTART': '1', 13:22:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:22:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:22:03 INFO - 'PWD': '/builds/slave/test', 13:22:03 INFO - 'SHELL': '/bin/bash', 13:22:03 INFO - 'SHLVL': '1', 13:22:03 INFO - 'TERM': 'linux', 13:22:03 INFO - 'TMOUT': '86400', 13:22:03 INFO - 'USER': 'cltbld', 13:22:03 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1472156485.619106-482549871', 13:22:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:22:03 INFO - '_': '/tools/buildbot/bin/python'} 13:22:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:22:03 INFO - Cleaning up... 13:22:03 INFO - Return code: 0 13:22:03 INFO - Running post-action listener: _resource_record_post_action 13:22:03 INFO - Running post-action listener: _start_resource_monitoring 13:22:03 INFO - Starting resource monitoring. 13:22:03 INFO - [mozharness: 2016-08-25 20:22:03.854321Z] Finished create-virtualenv step (success) 13:22:03 INFO - [mozharness: 2016-08-25 20:22:03.854827Z] Running install step. 13:22:03 INFO - Running pre-action listener: _resource_record_pre_action 13:22:03 INFO - Running main action method: install 13:22:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:22:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:22:04 INFO - Reading from file tmpfile_stdout 13:22:04 INFO - Detecting whether we're running mozinstall >=1.0... 13:22:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:22:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:22:04 INFO - Reading from file tmpfile_stdout 13:22:04 INFO - Output received: 13:22:04 INFO - Usage: mozinstall [options] installer 13:22:04 INFO - Options: 13:22:04 INFO - -h, --help show this help message and exit 13:22:04 INFO - -d DEST, --destination=DEST 13:22:04 INFO - Directory to install application into. [default: 13:22:04 INFO - "/builds/slave/test"] 13:22:04 INFO - --app=APP Application being installed. [default: firefox] 13:22:04 INFO - mkdir: /builds/slave/test/build/application 13:22:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:22:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:22:20 INFO - Reading from file tmpfile_stdout 13:22:20 INFO - Output received: 13:22:20 INFO - /builds/slave/test/build/application/firefox/firefox 13:22:20 INFO - Running post-action listener: _resource_record_post_action 13:22:20 INFO - [mozharness: 2016-08-25 20:22:20.230447Z] Finished install step (success) 13:22:20 INFO - [mozharness: 2016-08-25 20:22:20.230695Z] Running run-tests step. 13:22:20 INFO - Running pre-action listener: _resource_record_pre_action 13:22:20 INFO - Running main action method: run_tests 13:22:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:22:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:22:20 INFO - Python 2.7.3 13:22:20 INFO - Return code: 0 13:22:20 INFO - grabbing minidump binary from tooltool 13:22: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')]} 13:22:20 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 0x1a6d090>, '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 0x1a709b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a70e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:22:20 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:22:20 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 13:22:20 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 13:22:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:22:20 INFO - Return code: 0 13:22:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:22:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:22:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:22:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:22:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:22:20 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/PmjOhxdCQ1OTV7Z3BPuKtw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:22:20 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/PmjOhxdCQ1OTV7Z3BPuKtw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:22:20 INFO - Using env: {'DISPLAY': ':0', 13:22:20 INFO - 'HOME': '/home/cltbld', 13:22:20 INFO - 'LANG': 'en_US.UTF-8', 13:22:20 INFO - 'LANGUAGE': 'en_US:en', 13:22:20 INFO - 'LOGNAME': 'cltbld', 13:22:20 INFO - 'MAIL': '/var/mail/cltbld', 13:22:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:22:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:22:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:22:20 INFO - 'MOZ_NO_REMOTE': '1', 13:22:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:22:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:22:20 INFO - 'NO_EM_RESTART': '1', 13:22:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:22:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:22:20 INFO - 'PWD': '/builds/slave/test', 13:22:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:22:20 INFO - 'SHELL': '/bin/bash', 13:22:20 INFO - 'SHLVL': '1', 13:22:20 INFO - 'TERM': 'linux', 13:22:20 INFO - 'TMOUT': '86400', 13:22:20 INFO - 'USER': 'cltbld', 13:22:20 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1472156485.619106-482549871', 13:22:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:22:20 INFO - '_': '/tools/buildbot/bin/python'} 13:22:20 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/PmjOhxdCQ1OTV7Z3BPuKtw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:22:20 INFO - mozversion application_buildid: 20160825123516 13:22:20 INFO - mozversion application_changeset: 4988e9ed22f34ffa92723a16b0be9f82f48fe3e9 13:22:20 INFO - mozversion application_display_name: Nightly 13:22:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:22:20 INFO - mozversion application_name: Firefox 13:22:20 INFO - mozversion application_remotingname: firefox 13:22:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:22:20 INFO - mozversion application_vendor: Mozilla 13:22:20 INFO - mozversion application_version: 51.0a1 13:22:20 INFO - mozversion platform_buildid: 20160825123516 13:22:20 INFO - mozversion platform_changeset: 4988e9ed22f34ffa92723a16b0be9f82f48fe3e9 13:22:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:22:20 INFO - mozversion platform_version: 51.0a1 13:22:20 INFO - using testdate: 1472156540 13:22:20 INFO - actual date: 1472156540 13:22:20 INFO - starting webserver on 'localhost:44205' 13:22:20 INFO - SUITE-START | Running 2 tests 13:22:20 INFO - TEST-START | dromaeo_css 13:22:20 INFO - operating with platform_type : linux_ 13:22:20 INFO - Initialising browser for dromaeo_css test... 13:22:20 INFO - TEST-INFO | started process 16384 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQFiuGA/profile http://localhost:44205/getInfo.html) 13:22:25 INFO - PROCESS | 16384 | __metrics Screen width/height:1600/1200 13:22:25 INFO - PROCESS | 16384 | colorDepth:24 13:22:25 INFO - PROCESS | 16384 | Browser inner width/height: 1024/697 13:22:25 INFO - PROCESS | 16384 | __metrics 13:22:26 INFO - PROCESS | 16384 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:22:26 INFO - PROCESS | 16384 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:22:27 INFO - TEST-INFO | 16384: exit 0 13:22:27 INFO - Browser initialized. 13:22:27 INFO - Running cycle 1/1 for dromaeo_css test... 13:22:27 INFO - TEST-INFO | started process 16466 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQFiuGA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:22:39 INFO - PROCESS | 16466 | RSS: Main: 179339264 13:22:39 INFO - PROCESS | 16466 | 13:23:30 INFO - PROCESS | 16466 | 1472156610696 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 13:25:44 INFO - PROCESS | 16466 | Cycle 1(1): loaded http://localhost:44205/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44205/tests/dromaeo/cssquery-ext.html) 13:25:45 INFO - PROCESS | 16466 | RSS: Main: 274477056 13:25:45 INFO - PROCESS | 16466 | 13:28:48 INFO - PROCESS | 16466 | Cycle 1(1): loaded http://localhost:44205/tests/dromaeo/cssquery-ext.html (next: http://localhost:44205/tests/dromaeo/cssquery-jquery.html) 13:28:48 INFO - PROCESS | 16466 | RSS: Main: 273842176 13:28:48 INFO - PROCESS | 16466 | 13:31:51 INFO - PROCESS | 16466 | Cycle 1(1): loaded http://localhost:44205/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44205/tests/dromaeo/cssquery-mootools.html) 13:31:51 INFO - PROCESS | 16466 | RSS: Main: 217296896 13:31:51 INFO - PROCESS | 16466 | 13:34:54 INFO - PROCESS | 16466 | Cycle 1(1): loaded http://localhost:44205/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44205/tests/dromaeo/cssquery-prototype.html) 13:34:54 INFO - PROCESS | 16466 | RSS: Main: 221491200 13:34:54 INFO - PROCESS | 16466 | 13:37:57 INFO - PROCESS | 16466 | Cycle 1(1): loaded http://localhost:44205/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44205/tests/dromaeo/cssquery-yui.html) 13:37:58 INFO - PROCESS | 16466 | RSS: Main: 218513408 13:37:58 INFO - PROCESS | 16466 | 13:41:01 INFO - PROCESS | 16466 | Cycle 1(1): loaded http://localhost:44205/tests/dromaeo/cssquery-yui.html (next: http://localhost:44205/tests/dromaeo/cssquery-dojo.html) 13:41:01 INFO - PROCESS | 16466 | RSS: Main: 310284288 13:41:01 INFO - PROCESS | 16466 | 13:41:01 INFO - PROCESS | 16466 | __start_tp_report 13:41:01 INFO - PROCESS | 16466 | _x_x_mozilla_page_load 13:41:01 INFO - PROCESS | 16466 | _x_x_mozilla_page_load_details 13:41:01 INFO - PROCESS | 16466 | |i|pagename|runs| 13:41:01 INFO - PROCESS | 16466 | |0;dojo.html;2568.7174410814805;2587.767100960913;2594.792416606671;2605.517979173852;2631.513170063537;4428.047969686517;4506.549345065492;4567.429071366079;4657.673962822608;4719.858404247874;4568.794404251808;4598.678092533524;4612.792424340904;4622.191116554598;4652.185867473196;4157.708960372775;4167.083241686824;4242.575742425764;4309.181255561433;4365.519792822787;4309.784510774464;4317.11499142675;4333.046729719473;4336.046069864625;4373.781310934441;4147.751134931914;4182.498100227992;4185.874423767292;4301.741895486281;4322.265214913472;4200.978995105005;4202.789860506962;4252.702310838243;4262.957370426287;4265.55211702773;4150.813213405404;4166.937495937564;4171.770552619605;4220.472440944882;4269.551697071794;4590.440720049659;4604.884877878047;4649.604783593399;4657.813687452532;4685.742284174369;4863.562279394871;4894.559489645949;4942.851714448572;4945.752712364368;4949;5003.274525193827;5016.673916195436;5018.347614810052;5022.146235139999;5076.720780357079;4690.929636055462;4700.2244629635725;4701.388819453449;4710.646701497401;4712.387389639325;4922.360093187863;5016.072026675077;5073.34046573943;5086.440491545927;5169.741512924339;4885.60915126789;4911.066897289504;4914.459409464956;4916.287138364917;4974.37820272466;4972.801087956441;4984.252362145708;4988.401391832931;4991.925121123186;4996.300517927493;4749.572538471485;4851.75741212945;4892.315075889378;4901.2893130496595;4984.975075124601;4925.852224433273;4930.531599498114;4934.5312195341385;4937.136001199776;4990.975045124751;4246.299360605465;4254.149170165979;4257.127288905829;4258.638015768633;4306.354046892991;3610.819459027038;3632.219072899339;3658.926821463556;3688.188598508324;3734.8879533614036;4300.827966881289;4312.611864932109;4318.632916202095;4361.193179261847;4368;4947.777350019258;4961.677490963076;4965.726885021359;4980.277859710394;5033.874153146201;4136.855210067633;4244.0663054128045;4250.128723611714;4284.228838809045;4292.5063617683745;4505.234110201273;4520.638348932078;4525.660575456854;4571.771411429415;4583.679142460062;4727.479977202505;4736.123817093849;4737.24204127338;4737.502562230985;4800.927986080142;4777.140114779373;4877.463479017234;4906.779194936165;4914.5085491452;4979.576735977483;4651.325557794168;4664.86005419838;4666.440027196758;4710.905781884275;4721.150192965162;4862.027594481188;4862.07620552094;4863.56227939473;4869.659123861437;4891.021795640815;4804.375431193923;4861.440934292602;4872.610191184767;4894.119058569349;4934.062528119646;4805.735684537244;4826.034793041335;4827.372441582572;4851.95148048515;4886;4814.398200224972;4815.30178124177;4830.058138662927;4839.733814640088;4891;4617.307403889444;4699.530046995274;4721.858344249678;4738.099761045391;4740.383750112601;4803.663743537919;4822.517748225149;4827.806887724592;4873.7806798694855;4886.584640305614;4706.1764191267075;4725.976370118127;4731.479537250831;4732.337472753748;4784.497627749036 13:41:01 INFO - PROCESS | 16466 | |1;ext.html;567.1945836911588;567.4070596226943;572.367533875068;573.7418161827176;575.2062154227166;28026.57960130597;37184.25631487369;38605;38740;42618.57381426192;39581;39668.60331396685;39969.8001509992;40058.599414005854;40136.19727605446;7530.8117297067465;7661.23387661235;7664.156942736295;7674.501157424777;7675.3092221700035;7295.234000429958;9561;9859.161971232417;9867.16129129025;10171.338862973884;9963.202943764481;10066.496675166249;10076.19390448766;10076.244281678866;10078.294519383646;9834.852477212848;9862;9890.703278901645;9904.603815847357;9910.851337229948;9506.904930950672;9556.761080972961;9558.474283914382;9571.664991725256;9573.808523829553;36344;36542.45186322207;36555.08612284688;36569.45145822815;36587;2971.940561188764;3097.132802815215;3186.9681303186903;3385.830708464567;3430.828458577086;27683;28060.158195254175;28169;28288.43423131526;29609.703902961126;3179.650238473766;3187.8406079696156;3202.1034110449114;3241.33552621712;3271.2966712156763;177580;178177;178501;178595;178706;30272.243193920327;49230.50769492259;49461;49463.25805112926;49536.50463495319;31289.687103129134;32654.51018234681;32800;32805.17987050343;32818.34363312768;12320.81518777219;12440;12442;12455.377231138407;12503.124781265406;8985.281177505783;9117.680881169259;10280.742981425374;10310.175185985103;10435.426051567236;7252.673629686677;7316.085489313836;7424.480286379901;7674.53952762836;7691.730789422343;2961.8964875263746;3009.7441717454262;3034.0594415731193;3040.6047213862057;3059.586955760988;813.5891374855778;820.2904487618287;852.2627926843236;857.2070834478083;857.562643052048;25073.874630627095;26216.344591384986;26641.733582664314;26903.327416814343;27355.179344619693;923.1645360948353;942.9952850235842;961.7499450142873;967.3132076225818;970.6214576315243;13386.531471398454;13820.654483637789;14317.284135793168;14424.927875360556;14543;382161;447287;451068;452239;680689;47689;48336.516634833904;48356.5164348359;48418.27372589414;48449.75775121102;1099.5436893689189;1171.6367925942984;1174.5888938871497;1207.722223888493;1208.3233389301843;26137.6079358806;29101;29128.7087129126;29161.125166245045;29608.259793505335;39520;45259.54740452553;46622;46636.300455492514;51320;354275.17285166174;357280;357407;357448;357560;23943.52112957766;25046.123385681414;38526.42210366791;38871.41692874552;39231.80384098061;38838.6116138835;39089.21821563496;39234.803825980685;39373.80313098416;39464.210715784946;33256.33487330288;33852.83073584616;33970.66029339675;34164.658353417144;34360.82819585886;33150.5027424584;33988.32023359568;34010.65989340075;34052.14869628279;34363.31273374568;33208.50187247145;34083.05795659665;34147.31705365829;34149;34375.31249375048;29303.70696293095;30358.69641303559;30779.692203077684;31115.533267001465;31272.374552509278;23907.11812043778;24238.51522969566;24240.87879560591;24364.51270974606;24724.13465528698 13:41:01 INFO - PROCESS | 16466 | |2;jquery.html;350.23124242288185;366.8715949417704;377.1250698379759;378.445577229359;386.87039841653046;12868.420921058552;16106;16331.673366532663;16684.165791710395;17551.12244387782;16734.916325418355;16751.162441877917;17447.73828392572;17682.557936051606;17758;4850.611951043926;4919.655624106314;4990.226514890198;5007.399112106552;5014.548690617844;3707.536557930259;5009.649324547283;5017.096922553938;5512.614117011811;5734.79928202513;5793.942060579382;5799.710014499279;5810.070388737803;5811.0702287633985;5818;5641.52047075997;5793.826185214451;5886.175935369051;5908.793192238294;5916;5223.503767142115;5223.6865788052455;5227.947720522784;5230.8169214077325;5231.450697676765;20448.284310049225;20668.17327306906;20770.376888693212;20922;21048.68426973581;1835.3943198744516;1985.076939223268;2007.1770574064562;2013.4563667809755;2075.8962051897497;12963.805542916863;13425.328733563283;13532.864671353258;14038.789418158736;14199.876027274087;1650.645111301064;1699.8555122814575;1743.4159556548445;1780.5103596510933;1828.3052440072688;64657.67671161661;68160;68697.3130268696;68823;69790.65104674496;9548;9729.805403891882;9900.851487227697;10077.949610252048;10079.244056695778;13351.866481335257;13454.394552245172;13455.25996070206;13455.932720336335;13464.124831885896;7243.5653860768525;7290.161631412456;7325.670344834495;7438.4049276057785;7478.364339031244;6733.528652994243;6900.965495172492;7083.114610673666;7098.219195888448;7102.254263302382;6054.545909056838;6221.2845522765465;6271.372862713783;6290.654014029181;6298.338674439118;1733.6706025855046;1752.4567384110967;1765.1086201468434;1775.14792899409;1776.7917815885064;850.2432834777053;852.1648784191403;857.4298091769028;889.0442774017956;900.1943260781563;17104.657906841792;17397.043162625923;17871.73192402115;17936.820631793777;18035;842.6123982967904;852.953087580189;885.6368888755579;902.5622573052065;936.1434287626881;9474.289428292906;9971.950140249397;10070.244731645156;10105.191584673208;10232.897671023344;383043;389577;390959;401461;402064;69235.65382173158;69473;70000.64999675071;71954.64022679852;72877.6356118216;885.7608445719619;918.2975024106564;928.5867788834039;936.0779632062413;937.5218638494417;15716.60708482297;16033.599160021093;16354.264058117174;16384.525392714713;16505.917470412573;37499.625003749614;38507.229855402176;38566;39192;39251.803740981115;49987;50234.49765502445;53720;54833.451665484434;55087.724561376934;7728.908436625395;7756.92243077562;7874.13384527713;7887.487313324616;8025.638846251816;11868.287902725864;11872.347020913932;12002.159848810848;12137.635870923887;12440.377981100728;9480.715578532656;9930.155936745457;10094.031663825484;10161.136303414292;10320.380777153396;10295.794084118126;10507.579696812041;10612.628558000433;10622.36265824053;10755.354678719303;9874.75313117149;9982.850257246293;10173.186145108522;10460.110890574386;10462.63380781669;7494.475386723095;7721.420893433127;7769.805754856174;7770.14528401864;7812.218778122142;8847.292216622525;9954.303198776017;10055.346402483816;10135.49322533885;10444.268901177149 13:41:01 INFO - PROCESS | 16466 | |3;mootools.html;1253.6991122130692;1327.9203247805133;1379.599916024353;1415.3277193333167;1630.7553866919968;7310;7637.732679356223;7645.235476452352;7688.461807673465;7700.3454706349885;7566.735164269252;7673.501222420538;7694.576798276093;7697.191794861543;7698;2152.3973287479494;2179.607670619288;2182.9126834926665;2183.727034120735;2186.4424571734266;2083.906224219906;2115.5874604452138;2167.5773224221284;2177.5536015116863;2179.9128034878586;2125.2880285104507;2139;2145.0240140736005;2147.0552956699003;2174.412908514708;2115.925942592002;2120.4486833423266;2121.5438680683574;2122.1405330841035;2124.192806733447;2053.9281125160696;2118.4915620251027;2129.2866889592005;2129.6699011653063;2132.605467988427;7588.051493563305;7689.9615501922135;7703.768886933401;7773.416993725493;7775;4302.741835489881;4477.328400739882;4478.753668548228;4483.08096840147;4485.753283569403;2843.516602177614;2958.5118455454826;2988.2678743707716;2999.3851260491547;3005.6994300569986;925.3892430995578;926.5274709898;944.7968686732316;960.870282511866;962.3552220012539;9942.950285248528;9970.651027214086;9998.80002399948;10009.59961601535;10038.598456061822;4027.7381970171846;4086;4101.671866250693;4109.8972525687095;4179.226843034048;8019.318357939641;8046.517208967481;8048.839023219502;8049.55727434985;8064.395170362129;4335.328024156261;4343.457067866517;4350.282203436397;4358.433403657505;4385.342198670161;3519.1202199450136;3971.3645816669195;3994.9201015979515;4011.538673052578;4130.855420060284;3287.6219234787827;3331.217163966466;3419.982900085484;3436.810975396377;3437.9484307735406;990.6730778843108;1008.5461542305992;1022.892596277395;1032.939286124187;1033.2767063055892;827.1893544326593;832.9042160151539;835.7701632051235;844.0968164064392;860.4407135362064;5274.657147285414;5311.442298558673;5375.919361209585;5496.862578435571;5657.43425657431;424.974501529903;430.9310510318334;437.22610978568395;438.52420124165;440.4186473854545;3633.8364773585254;3679.1354031802507;3696.5933747287777;3730.403135498307;3764.435334699817;9308.115729005734;9800.166985806287;9803.950980245054;9840.081184169161;9865.210783137332;9722.416655000581;9725.610975560898;9747.415155090717;9756.90243097574;9757.316987810927;7264.891026634605;7372.963135184397;7374.52065615744;7380.77857664271;7382.630868456663;5294.417614062527;5333.893322133458;5445.50990410865;5466.91799622998;5578.693171875586;8757.824843502967;8989.595468203815;9014.459132452073;9049.683261085831;9082.954585227297;9090.772730681785;9097.09029097085;9144.862827057732;9150.588223529823;9152.725418237464;5835.94164058371;6590.80227593173;6654.467642588678;6658.500612454182;6659.866802664016;6833.077534532775;6948.965255173692;6974.058502102354;7443.627818609156;7506.3244308012545;6626.635535045619;6700.6984685688285;6734.8653026940165;6747.763828265987;6797.150356205474;6508.284088750328;6548.345165483413;6557.639329836905;6576.539642224999;6627.105340778933;6368.426841584094;6480;6491.415772580491;6494.772682956074;6504.544681872224;4591.586757191869;4616.561426664462;4639.280911458729;4737.620990320697;4866.853994380174;4627.421572303462;4650.348951146774;4692.906141877212;4727.078219747116;4817.8313759018265 13:41:01 INFO - PROCESS | 16466 | |4;prototype.html;295.2750996304074;304.14231866137493;309.9736522395596;311.1055714819892;312.79199332443926;4598.97700511497;4739.857804265869;4756.429228492577;4804.2073057945445;4805.735684537349;4576.610988066019;4673.813047478096;4694.882627934303;4703.647226458021;4713.528647135293;3742.9438558421643;3745.325841348556;3751.08098515864;3753.756005859624;3755.1550901047317;3581.426971684531;3646.781193128421;3747.775133491999;3757.6993840492833;3772.302124107049;3708.1100535871333;3726.1988672435423;3731.6641502264793;3736.8505259789576;3738.6448287412786;3711.9072023199365;3712.70055480581;3718.2749363874054;3722.40441529354;3728.403455447129;3301.4552598821165;3302.256992176741;3307.4708046712412;3309.7517686173633;3320.5185248138882;4460.576245256695;4590.173768721629;4623.53764623535;4640.350350950869;4645.814167433298;4223.387608796707;4243.61807437329;4244.342126970325;4252.702310838243;4264.9147017059795;4925.109163760625;4926.950730492685;4932.901341973176;4938.604911607063;4950.9009819803405;3384.4415671414185;3502.176988407722;3615.421532554805;3619.60184379718;3631.7457777955556;5145.742712864342;5156.484351564851;5161.66449180802;5191.131192770599;5198.298229738974;3536.840842162109;3555.3244883472057;3555.67103547177;3556.76881002734;3557.3418917500344;3585.9421470666216;3608.8195590220384;3609.7112231021456;3619.8914032578537;3620.3664358737115;3984.6812255019527;4153.522344930311;4173.52004519478;4202.747835129902;4207.852725154605;5001.399832020181;5010.874728131826;5013.222950442687;5014.272930425068;5029.597632189416;1217.8903898648987;1233.6052463211865;1253.931033793132;1264.1782841153324;1272.096811264013;836.2766207230824;846.5851732650957;857.3068190324185;861.237804542984;862.1421685423044;4354.651627869763;4358.716683415568;4360.302351623725;4385.407969924019;4393.450818647669;5034.194528875362;5064.11378008847;5067.569256613156;5077.39071311445;5077.771500282496;4368.2355587772645;4368.410264614236;4368.978155109204;4372.825086996548;4395.582419670126;2273.715785526809;2352.847064940773;2360.3273067176115;2400.6519054737314;2409.217004473553;4284.271673815459;4303.139372125587;4307.698461107692;4313.913721725611;4331.350297455344;4584.587387135174;4611.377464042312;4622.607078398307;4648.86053418398;4653.697509661861;4239.876432745264;4304.612584867377;4477.485089214717;4819.542143496362;4871;5119.334486516729;5125.79496820123;5126.256692779451;5127.154019586876;5129.204973229155;5043.798248070036;5068.2904393384215;5071.416787069535;5072.351485767067;5085.618578606545;4658.417697787777;4845.733484658378;4857.1742803724155;4878.756062196805;4896.706197628154;3643.690286325692;3652.6895213906055;3660.066682995819;3666.2300916807767;3677.705783537364;5098.260752190986;5134.152864777419;5140.151874940593;5154.948450515447;5175.266285794301;4824.589909857701;4830.661853670209;4890.9021819562695;4908.263760435963;4935.383077115361;4957.652964292465;4960.801567937242;4972;4984.4517103117905;4986.63135010867;4811.879703007313;4909.533594308535;4922.941567562991;4945.2582112683385;4948.529889660476;4989.226669866177;4993.6254780892305;5006.07387633289;5012.77442515095;5017.745563609098;4897.41231052276;4899.191633380452;4903.362562866804;4906.8714195734465;4914.754262286943 13:41:01 INFO - PROCESS | 16466 | |5;yui.html;632.9587081661642;705.7388766156523;728.6575309604484;730.9415246780255;739.3198257603004;13386.531471398503;14560.635984100389;14634.560963171096;14724.6318842029;14786.260686965648;13327.46690132396;13414.530491432803;13462.192268463874;13465.865341346584;13469.797953030713;737.1044181319695;744.1293686386927;762.8054846014259;762.9923700762977;764.4343186042345;755.3428517190025;756.0473803008222;756.1191212237736;756.6141267953356;757.2049348184412;798.5807451088167;800.2877439079224;800.3437181511163;800.403699244064;801.1067659559578;789.1319548496665;790.6837265093951;791.2087912087912;791.3550456378091;792.4096548071694;583.547750493371;584.0392554248238;584.2492397269531;584.5498965796313;585.4818485640196;12640.241585504898;12714.554990575378;12773.552925647651;12776;12792.296423696693;12420.441080151415;12653;12809.167404118702;12885.291308978003;13030.413631386611;9833.31166818323;9897.604095836157;9968.302218844683;9985.800283994353;10045.79908401828;3213.887513937001;3255.1699316674335;3262.2333751568362;3312.602487701491;3418.8119653419053;42448.57551424508;48157;51534;66180.66909665469;67778.3222167782;10229.386236825814;10233.283670143168;10272.280940334254;10338.12125969301;10444.63443779464;17822.10889455548;17826.821731782777;17829.10854457272;17868.46394608164;17889.105544722974;5101.9744901276;6966.477514186457;6977.9994602321485;6983.441324694012;6999.860002800017;3706.1661126246377;3788.7726736395903;3820.751651142667;3822.5604055533413;3982.960170398259;2903.5499497577907;3074.031680020786;3079.276370053036;3080.029790615949;3081;522.3496746550493;525.4430303877901;526.4630077321111;538.0879409401027;543.5515699547889;488.9193283108247;615.230961298377;632.8196464007735;646.1858058845888;657.0505619380045;7970.84058318842;8225.300849427866;8516.361272904556;8911.821763564822;8941.37410381267;606.9544784141119;610.3255902228063;611.5382885921101;618.5484596244677;625.4714766022704;4037.37420699792;4259.574042595716;4262.595053469915;4287.957120428819;4369.934450983238;77087;77714;93305.5334723322;96204;96724;77907;84633.57683211545;87964.5601771987;90940.54529727309;96691;77820.22179778243;78642.6067869657;78726.6063669678;80787.59606202049;80791.59604201942;8960;9237.584308706259;9340.392874463138;9396.154346108882;9512.571934262836;28571.14286571406;28597.85701071481;31439.84280078585;38139.61860381471;39588.80205598954;36049.27901442009;36239.637603623625;48184.036319272716;52406.47593524016;54007.97896273617;12614;12851.485940562272;12882.867262774478;13128.540501082416;13390.062695611214;13528.39122239482;13585.32073396346;13635.727285454434;14126.364313606118;14818.036827606602;12806.551770687982;12950.287734174712;13075.917927643079;13212.933935330646;14209.857901420854;10921.945390272998;11042.668719938414;11131.777364452828;11270.211085224284;11325.490352933974;11730.824037639271;12780.552680656132;12784.488620455078;12894.226346419246;12963.481460741465;10045.347052441568;10288.228382871164;10370.896291036994;10396.116330111723;10843.512041957973;9876.950615246878;9966.302358835102;10087.69736907894;10105.848412273675;10154.035366640157 13:41:01 INFO - PROCESS | 16466 | __end_tp_report 13:41:01 INFO - PROCESS | 16466 | __start_cc_report 13:41:01 INFO - PROCESS | 16466 | _x_x_mozilla_cycle_collect,972 13:41:01 INFO - PROCESS | 16466 | __end_cc_report 13:41:01 INFO - PROCESS | 16466 | __startTimestamp1472157661543__endTimestamp 13:41:01 INFO - PROCESS | 16466 | 13:41:01 INFO - PROCESS | 16466 | ------- Summary: start ------- 13:41:01 INFO - PROCESS | 16466 | Number of tests: 6 13:41:01 INFO - PROCESS | 16466 | 13:41:01 INFO - PROCESS | 16466 | [#0] dojo.html Cycles:165 Average:4580.09 Median:4721.15 stddev:476.10 (10.1%) stddev-sans-first:450.66 13:41:01 INFO - PROCESS | 16466 | Values: 2568.7 2587.8 2594.8 2605.5 2631.5 4428.0 4506.5 4567.4 4657.7 4719.9 4568.8 4598.7 4612.8 4622.2 4652.2 4157.7 4167.1 4242.6 4309.2 4365.5 4309.8 4317.1 4333.0 4336.0 4373.8 4147.8 4182.5 4185.9 4301.7 4322.3 4201.0 4202.8 4252.7 4263.0 4265.6 4150.8 4166.9 4171.8 4220.5 4269.6 4590.4 4604.9 4649.6 4657.8 4685.7 4863.6 4894.6 4942.9 4945.8 4949.0 5003.3 5016.7 5018.3 5022.1 5076.7 4690.9 4700.2 4701.4 4710.6 4712.4 4922.4 5016.1 5073.3 5086.4 5169.7 4885.6 4911.1 4914.5 4916.3 4974.4 4972.8 4984.3 4988.4 4991.9 4996.3 4749.6 4851.8 4892.3 4901.3 4985.0 4925.9 4930.5 4934.5 4937.1 4991.0 4246.3 4254.1 4257.1 4258.6 4306.4 3610.8 3632.2 3658.9 3688.2 3734.9 4300.8 4312.6 4318.6 4361.2 4368.0 4947.8 4961.7 4965.7 4980.3 5033.9 4136.9 4244.1 4250.1 4284.2 4292.5 4505.2 4520.6 4525.7 4571.8 4583.7 4727.5 4736.1 4737.2 4737.5 4800.9 4777.1 4877.5 4906.8 4914.5 4979.6 4651.3 4664.9 4666.4 4710.9 4721.2 4862.0 4862.1 4863.6 4869.7 4891.0 4804.4 4861.4 4872.6 4894.1 4934.1 4805.7 4826.0 4827.4 4852.0 4886.0 4814.4 4815.3 4830.1 4839.7 4891.0 4617.3 4699.5 4721.9 4738.1 4740.4 4803.7 4822.5 4827.8 4873.8 4886.6 4706.2 4726.0 4731.5 4732.3 4784.5 13:41:01 INFO - PROCESS | 16466 | 13:41:01 INFO - PROCESS | 16466 | [#1] ext.html Cycles:180 Average:47754.30 Median:34369.31 stddev:97941.69 (285.0%) stddev-sans-first:98152.36 13:41:01 INFO - PROCESS | 16466 | Values: 567.2 567.4 572.4 573.7 575.2 28026.6 37184.3 38605.0 38740.0 42618.6 39581.0 39668.6 39969.8 40058.6 40136.2 7530.8 7661.2 7664.2 7674.5 7675.3 7295.2 9561.0 9859.2 9867.2 10171.3 9963.2 10066.5 10076.2 10076.2 10078.3 9834.9 9862.0 9890.7 9904.6 9910.9 9506.9 9556.8 9558.5 9571.7 9573.8 36344.0 36542.5 36555.1 36569.5 36587.0 2971.9 3097.1 3187.0 3385.8 3430.8 27683.0 28060.2 28169.0 28288.4 29609.7 3179.7 3187.8 3202.1 3241.3 3271.3 177580.0 178177.0 178501.0 178595.0 178706.0 30272.2 49230.5 49461.0 49463.3 49536.5 31289.7 32654.5 32800.0 32805.2 32818.3 12320.8 12440.0 12442.0 12455.4 12503.1 8985.3 9117.7 10280.7 10310.2 10435.4 7252.7 7316.1 7424.5 7674.5 7691.7 2961.9 3009.7 3034.1 3040.6 3059.6 813.6 820.3 852.3 857.2 857.6 25073.9 26216.3 26641.7 26903.3 27355.2 923.2 943.0 961.7 967.3 970.6 13386.5 13820.7 14317.3 14424.9 14543.0 382161.0 447287.0 451068.0 452239.0 680689.0 47689.0 48336.5 48356.5 48418.3 48449.8 1099.5 1171.6 1174.6 1207.7 1208.3 26137.6 29101.0 29128.7 29161.1 29608.3 39520.0 45259.5 46622.0 46636.3 51320.0 354275.2 357280.0 357407.0 357448.0 357560.0 23943.5 25046.1 38526.4 38871.4 39231.8 38838.6 39089.2 39234.8 39373.8 39464.2 33256.3 33852.8 33970.7 34164.7 34360.8 33150.5 33988.3 34010.7 34052.1 34363.3 33208.5 34083.1 34147.3 34149.0 34375.3 29303.7 30358.7 30779.7 31115.5 31272.4 23907.1 24238.5 24240.9 24364.5 24724.1 13:41:01 INFO - PROCESS | 16466 | 13:41:01 INFO - PROCESS | 16466 | [#2] jquery.html Cycles:180 Average:24512.23 Median:4885.13 stddev:64777.12 (1326.0%) stddev-sans-first:64933.43 13:41:01 INFO - PROCESS | 16466 | Values: 350.2 366.9 377.1 378.4 386.9 12868.4 16106.0 16331.7 16684.2 17551.1 16734.9 16751.2 17447.7 17682.6 17758.0 4850.6 4919.7 4990.2 5007.4 5014.5 3707.5 5009.6 5017.1 5512.6 5734.8 5793.9 5799.7 5810.1 5811.1 5818.0 5641.5 5793.8 5886.2 5908.8 5916.0 5223.5 5223.7 5227.9 5230.8 5231.5 20448.3 20668.2 20770.4 20922.0 21048.7 1835.4 1985.1 2007.2 2013.5 2075.9 12963.8 13425.3 13532.9 14038.8 14199.9 1650.6 1699.9 1743.4 1780.5 1828.3 64657.7 68160.0 68697.3 68823.0 69790.7 9548.0 9729.8 9900.9 10077.9 10079.2 13351.9 13454.4 13455.3 13455.9 13464.1 7243.6 7290.2 7325.7 7438.4 7478.4 6733.5 6901.0 7083.1 7098.2 7102.3 6054.5 6221.3 6271.4 6290.7 6298.3 1733.7 1752.5 1765.1 1775.1 1776.8 850.2 852.2 857.4 889.0 900.2 17104.7 17397.0 17871.7 17936.8 18035.0 842.6 853.0 885.6 902.6 936.1 9474.3 9972.0 10070.2 10105.2 10232.9 383043.0 389577.0 390959.0 401461.0 402064.0 69235.7 69473.0 70000.6 71954.6 72877.6 885.8 918.3 928.6 936.1 937.5 15716.6 16033.6 16354.3 16384.5 16505.9 37499.6 38507.2 38566.0 39192.0 39251.8 49987.0 50234.5 53720.0 54833.5 55087.7 7728.9 7756.9 7874.1 7887.5 8025.6 11868.3 11872.3 12002.2 12137.6 12440.4 9480.7 9930.2 10094.0 10161.1 10320.4 10295.8 10507.6 10612.6 10622.4 10755.4 9874.8 9982.9 10173.2 10460.1 10462.6 7494.5 7721.4 7769.8 7770.1 7812.2 8847.3 9954.3 10055.3 10135.5 10444.3 13:41:01 INFO - PROCESS | 16466 | 13:41:01 INFO - PROCESS | 16466 | [#3] mootools.html Cycles:180 Average:5048.78 Median:5410.71 stddev:2842.38 (52.5%) stddev-sans-first:2836.04 13:41:01 INFO - PROCESS | 16466 | Values: 1253.7 1327.9 1379.6 1415.3 1630.8 7310.0 7637.7 7645.2 7688.5 7700.3 7566.7 7673.5 7694.6 7697.2 7698.0 2152.4 2179.6 2182.9 2183.7 2186.4 2083.9 2115.6 2167.6 2177.6 2179.9 2125.3 2139.0 2145.0 2147.1 2174.4 2115.9 2120.4 2121.5 2122.1 2124.2 2053.9 2118.5 2129.3 2129.7 2132.6 7588.1 7690.0 7703.8 7773.4 7775.0 4302.7 4477.3 4478.8 4483.1 4485.8 2843.5 2958.5 2988.3 2999.4 3005.7 925.4 926.5 944.8 960.9 962.4 9943.0 9970.7 9998.8 10009.6 10038.6 4027.7 4086.0 4101.7 4109.9 4179.2 8019.3 8046.5 8048.8 8049.6 8064.4 4335.3 4343.5 4350.3 4358.4 4385.3 3519.1 3971.4 3994.9 4011.5 4130.9 3287.6 3331.2 3420.0 3436.8 3437.9 990.7 1008.5 1022.9 1032.9 1033.3 827.2 832.9 835.8 844.1 860.4 5274.7 5311.4 5375.9 5496.9 5657.4 425.0 430.9 437.2 438.5 440.4 3633.8 3679.1 3696.6 3730.4 3764.4 9308.1 9800.2 9804.0 9840.1 9865.2 9722.4 9725.6 9747.4 9756.9 9757.3 7264.9 7373.0 7374.5 7380.8 7382.6 5294.4 5333.9 5445.5 5466.9 5578.7 8757.8 8989.6 9014.5 9049.7 9083.0 9090.8 9097.1 9144.9 9150.6 9152.7 5835.9 6590.8 6654.5 6658.5 6659.9 6833.1 6949.0 6974.1 7443.6 7506.3 6626.6 6700.7 6734.9 6747.8 6797.2 6508.3 6548.3 6557.6 6576.5 6627.1 6368.4 6480.0 6491.4 6494.8 6504.5 4591.6 4616.6 4639.3 4737.6 4866.9 4627.4 4650.3 4692.9 4727.1 4817.8 13:41:01 INFO - PROCESS | 16466 | 13:41:01 INFO - PROCESS | 16466 | [#4] prototype.html Cycles:180 Average:4082.58 Median:4587.38 stddev:1191.13 (26.0%) stddev-sans-first:1160.05 13:41:01 INFO - PROCESS | 16466 | Values: 295.3 304.1 310.0 311.1 312.8 4599.0 4739.9 4756.4 4804.2 4805.7 4576.6 4673.8 4694.9 4703.6 4713.5 3742.9 3745.3 3751.1 3753.8 3755.2 3581.4 3646.8 3747.8 3757.7 3772.3 3708.1 3726.2 3731.7 3736.9 3738.6 3711.9 3712.7 3718.3 3722.4 3728.4 3301.5 3302.3 3307.5 3309.8 3320.5 4460.6 4590.2 4623.5 4640.4 4645.8 4223.4 4243.6 4244.3 4252.7 4264.9 4925.1 4927.0 4932.9 4938.6 4950.9 3384.4 3502.2 3615.4 3619.6 3631.7 5145.7 5156.5 5161.7 5191.1 5198.3 3536.8 3555.3 3555.7 3556.8 3557.3 3585.9 3608.8 3609.7 3619.9 3620.4 3984.7 4153.5 4173.5 4202.7 4207.9 5001.4 5010.9 5013.2 5014.3 5029.6 1217.9 1233.6 1253.9 1264.2 1272.1 836.3 846.6 857.3 861.2 862.1 4354.7 4358.7 4360.3 4385.4 4393.5 5034.2 5064.1 5067.6 5077.4 5077.8 4368.2 4368.4 4369.0 4372.8 4395.6 2273.7 2352.8 2360.3 2400.7 2409.2 4284.3 4303.1 4307.7 4313.9 4331.4 4584.6 4611.4 4622.6 4648.9 4653.7 4239.9 4304.6 4477.5 4819.5 4871.0 5119.3 5125.8 5126.3 5127.2 5129.2 5043.8 5068.3 5071.4 5072.4 5085.6 4658.4 4845.7 4857.2 4878.8 4896.7 3643.7 3652.7 3660.1 3666.2 3677.7 5098.3 5134.2 5140.2 5154.9 5175.3 4824.6 4830.7 4890.9 4908.3 4935.4 4957.7 4960.8 4972.0 4984.5 4986.6 4811.9 4909.5 4922.9 4945.3 4948.5 4989.2 4993.6 5006.1 5012.8 5017.7 4897.4 4899.2 4903.4 4906.9 4914.8 13:41:01 INFO - PROCESS | 16466 | 13:41:01 INFO - PROCESS | 16466 | [#5] yui.html Cycles:180 Average:16939.28 Median:4328.95 stddev:23914.21 (552.4%) stddev-sans-first:23949.95 13:41:01 INFO - PROCESS | 16466 | Values: 633.0 705.7 728.7 730.9 739.3 13386.5 14560.6 14634.6 14724.6 14786.3 13327.5 13414.5 13462.2 13465.9 13469.8 737.1 744.1 762.8 763.0 764.4 755.3 756.0 756.1 756.6 757.2 798.6 800.3 800.3 800.4 801.1 789.1 790.7 791.2 791.4 792.4 583.5 584.0 584.2 584.5 585.5 12640.2 12714.6 12773.6 12776.0 12792.3 12420.4 12653.0 12809.2 12885.3 13030.4 9833.3 9897.6 9968.3 9985.8 10045.8 3213.9 3255.2 3262.2 3312.6 3418.8 42448.6 48157.0 51534.0 66180.7 67778.3 10229.4 10233.3 10272.3 10338.1 10444.6 17822.1 17826.8 17829.1 17868.5 17889.1 5102.0 6966.5 6978.0 6983.4 6999.9 3706.2 3788.8 3820.8 3822.6 3983.0 2903.5 3074.0 3079.3 3080.0 3081.0 522.3 525.4 526.5 538.1 543.6 488.9 615.2 632.8 646.2 657.1 7970.8 8225.3 8516.4 8911.8 8941.4 607.0 610.3 611.5 618.5 625.5 4037.4 4259.6 4262.6 4288.0 4369.9 77087.0 77714.0 93305.5 96204.0 96724.0 77907.0 84633.6 87964.6 90940.5 96691.0 77820.2 78642.6 78726.6 80787.6 80791.6 8960.0 9237.6 9340.4 9396.2 9512.6 28571.1 28597.9 31439.8 38139.6 39588.8 36049.3 36239.6 48184.0 52406.5 54008.0 12614.0 12851.5 12882.9 13128.5 13390.1 13528.4 13585.3 13635.7 14126.4 14818.0 12806.6 12950.3 13075.9 13212.9 14209.9 10921.9 11042.7 11131.8 11270.2 11325.5 11730.8 12780.6 12784.5 12894.2 12963.5 10045.3 10288.2 10370.9 10396.1 10843.5 9877.0 9966.3 10087.7 10105.8 10154.0 13:41:01 INFO - PROCESS | 16466 | -------- Summary: end -------- 13:41:01 INFO - PROCESS | 16466 | 13:41:02 INFO - TEST-INFO | 16466: exit 0 13:41:02 INFO - TEST-OK | dromaeo_css | took 1122010ms 13:41:02 INFO - TEST-START | kraken 13:41:02 INFO - operating with platform_type : linux_ 13:41:02 INFO - Initialising browser for kraken test... 13:41:02 INFO - TEST-INFO | started process 16768 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVAqS6Q/profile http://localhost:44205/getInfo.html) 13:41:07 INFO - PROCESS | 16768 | __metrics Screen width/height:1600/1200 13:41:07 INFO - PROCESS | 16768 | colorDepth:24 13:41:07 INFO - PROCESS | 16768 | Browser inner width/height: 1024/697 13:41:07 INFO - PROCESS | 16768 | __metrics 13:41:07 INFO - PROCESS | 16768 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:41:07 INFO - PROCESS | 16768 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:41:08 INFO - PROCESS | 16768 | console.error: PushService: 13:41:08 INFO - PROCESS | 16768 | stateChangeProcessEnqueue: Error transitioning state 13:41:08 INFO - PROCESS | 16768 | UnknownError 13:41:08 INFO - TEST-INFO | 16768: exit 0 13:41:08 INFO - Browser initialized. 13:41:08 INFO - Running cycle 1/1 for kraken test... 13:41:08 INFO - TEST-INFO | started process 16850 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVAqS6Q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:41:21 INFO - PROCESS | 16850 | RSS: Main: 179544064 13:41:21 INFO - PROCESS | 16850 | 13:41:23 INFO - PROCESS | 16850 | Cycle 1(1): loaded http://localhost:44205/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44205/tests/kraken/driver.html?testName=audio-beat-detection) 13:41:24 INFO - PROCESS | 16850 | RSS: Main: 241315840 13:41:24 INFO - PROCESS | 16850 | 13:41:27 INFO - PROCESS | 16850 | Cycle 1(1): loaded http://localhost:44205/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44205/tests/kraken/driver.html?testName=audio-dft) 13:41:28 INFO - PROCESS | 16850 | RSS: Main: 223801344 13:41:28 INFO - PROCESS | 16850 | 13:41:31 INFO - PROCESS | 16850 | Cycle 1(1): loaded http://localhost:44205/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44205/tests/kraken/driver.html?testName=audio-fft) 13:41:32 INFO - PROCESS | 16850 | RSS: Main: 301117440 13:41:32 INFO - PROCESS | 16850 | 13:41:34 INFO - PROCESS | 16850 | Cycle 1(1): loaded http://localhost:44205/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44205/tests/kraken/driver.html?testName=audio-oscillator) 13:41:34 INFO - PROCESS | 16850 | RSS: Main: 211976192 13:41:34 INFO - PROCESS | 16850 | 13:41:37 INFO - PROCESS | 16850 | Cycle 1(1): loaded http://localhost:44205/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44205/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:41:37 INFO - PROCESS | 16850 | RSS: Main: 213364736 13:41:37 INFO - PROCESS | 16850 | 13:41:40 INFO - PROCESS | 16850 | Cycle 1(1): loaded http://localhost:44205/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44205/tests/kraken/driver.html?testName=imaging-darkroom) 13:41:41 INFO - PROCESS | 16850 | RSS: Main: 252735488 13:41:41 INFO - PROCESS | 16850 | 13:41:45 INFO - PROCESS | 16850 | Cycle 1(1): loaded http://localhost:44205/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44205/tests/kraken/driver.html?testName=imaging-desaturate) 13:41:45 INFO - PROCESS | 16850 | RSS: Main: 250646528 13:41:45 INFO - PROCESS | 16850 | 13:41:48 INFO - PROCESS | 16850 | Cycle 1(1): loaded http://localhost:44205/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44205/tests/kraken/driver.html?testName=json-parse-financial) 13:41:49 INFO - PROCESS | 16850 | RSS: Main: 251047936 13:41:49 INFO - PROCESS | 16850 | 13:41:50 INFO - PROCESS | 16850 | Cycle 1(1): loaded http://localhost:44205/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44205/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:41:51 INFO - PROCESS | 16850 | RSS: Main: 213794816 13:41:51 INFO - PROCESS | 16850 | 13:41:53 INFO - PROCESS | 16850 | Cycle 1(1): loaded http://localhost:44205/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44205/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:41:54 INFO - PROCESS | 16850 | RSS: Main: 221741056 13:41:54 INFO - PROCESS | 16850 | 13:41:56 INFO - PROCESS | 16850 | Cycle 1(1): loaded http://localhost:44205/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44205/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:41:57 INFO - PROCESS | 16850 | RSS: Main: 222023680 13:41:57 INFO - PROCESS | 16850 | 13:41:59 INFO - PROCESS | 16850 | Cycle 1(1): loaded http://localhost:44205/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44205/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:42:00 INFO - PROCESS | 16850 | RSS: Main: 222441472 13:42:00 INFO - PROCESS | 16850 | 13:42:03 INFO - PROCESS | 16850 | Cycle 1(1): loaded http://localhost:44205/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44205/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:42:04 INFO - PROCESS | 16850 | RSS: Main: 220839936 13:42:04 INFO - PROCESS | 16850 | 13:42:05 INFO - PROCESS | 16850 | Cycle 1(1): loaded http://localhost:44205/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44205/tests/kraken/driver.html?testName=ai-astar) 13:42:06 INFO - PROCESS | 16850 | RSS: Main: 270434304 13:42:06 INFO - PROCESS | 16850 | 13:42:06 INFO - PROCESS | 16850 | __start_tp_report 13:42:06 INFO - PROCESS | 16850 | _x_x_mozilla_page_load 13:42:06 INFO - PROCESS | 16850 | _x_x_mozilla_page_load_details 13:42:06 INFO - PROCESS | 16850 | |i|pagename|runs| 13:42:06 INFO - PROCESS | 16850 | |0;ai-astar;115;114;129;113;114;114;113;114;114;113 13:42:06 INFO - PROCESS | 16850 | |1;audio-beat-detection;153;123;160;196;125;151;150;131;179;122 13:42:06 INFO - PROCESS | 16850 | |2;audio-dft;163;160;163;160;165;164;163;161;163;162 13:42:06 INFO - PROCESS | 16850 | |3;audio-fft;77;76;76;166;76;77;76;76;178;77 13:42:06 INFO - PROCESS | 16850 | |4;audio-oscillator;87;87;141;87;87;88;142;87;88;150 13:42:06 INFO - PROCESS | 16850 | |5;imaging-gaussian-blur;117;118;116;117;117;117;117;116;117;116 13:42:06 INFO - PROCESS | 16850 | |6;imaging-darkroom;145;146;146;145;146;146;146;146;146;146 13:42:06 INFO - PROCESS | 16850 | |7;imaging-desaturate;95;95;95;96;95;95;95;96;94;94 13:42:06 INFO - PROCESS | 16850 | |8;json-parse-financial;65;65;66;65;66;66;76;67;66;65 13:42:06 INFO - PROCESS | 16850 | |9;json-stringify-tinderbox;65;65;65;66;65;65;66;64;65;66 13:42:06 INFO - PROCESS | 16850 | |10;stanford-crypto-aes;92;83;82;84;91;83;83;82;93;83 13:42:06 INFO - PROCESS | 16850 | |11;stanford-crypto-ccm;135;135;139;146;132;133;134;133;167;136 13:42:06 INFO - PROCESS | 16850 | |12;stanford-crypto-pbkdf2;176;177;171;173;172;170;173;172;174;167 13:42:06 INFO - PROCESS | 16850 | |13;stanford-crypto-sha256-iterative;68;68;69;68;69;68;68;68;67;67 13:42:06 INFO - PROCESS | 16850 | __end_tp_report 13:42:06 INFO - PROCESS | 16850 | __start_cc_report 13:42:06 INFO - PROCESS | 16850 | _x_x_mozilla_cycle_collect,2005 13:42:06 INFO - PROCESS | 16850 | __end_cc_report 13:42:06 INFO - PROCESS | 16850 | __startTimestamp1472157726025__endTimestamp 13:42:06 INFO - PROCESS | 16850 | 13:42:06 INFO - PROCESS | 16850 | ------- Summary: start ------- 13:42:06 INFO - PROCESS | 16850 | Number of tests: 14 13:42:06 INFO - PROCESS | 16850 | 13:42:06 INFO - PROCESS | 16850 | [#0] ai-astar Cycles:10 Average:115.30 Median:114.00 stddev:4.85 (4.3%) stddev-sans-first:5.15 13:42:06 INFO - PROCESS | 16850 | Values: 115.0 114.0 129.0 113.0 114.0 114.0 113.0 114.0 114.0 113.0 13:42:06 INFO - PROCESS | 16850 | 13:42:06 INFO - PROCESS | 16850 | [#1] audio-beat-detection Cycles:10 Average:149.00 Median:152.00 stddev:24.85 (16.3%) stddev-sans-first:26.31 13:42:06 INFO - PROCESS | 16850 | Values: 153.0 123.0 160.0 196.0 125.0 151.0 150.0 131.0 179.0 122.0 13:42:06 INFO - PROCESS | 16850 | 13:42:06 INFO - PROCESS | 16850 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:1.65 (1.0%) stddev-sans-first:1.73 13:42:06 INFO - PROCESS | 16850 | Values: 163.0 160.0 163.0 160.0 165.0 164.0 163.0 161.0 163.0 162.0 13:42:06 INFO - PROCESS | 16850 | 13:42:06 INFO - PROCESS | 16850 | [#3] audio-fft Cycles:10 Average:95.50 Median:76.00 stddev:40.42 (53.2%) stddev-sans-first:42.31 13:42:06 INFO - PROCESS | 16850 | Values: 77.0 76.0 76.0 166.0 76.0 77.0 76.0 76.0 178.0 77.0 13:42:06 INFO - PROCESS | 16850 | 13:42:06 INFO - PROCESS | 16850 | [#4] audio-oscillator Cycles:10 Average:104.40 Median:87.00 stddev:27.66 (31.8%) stddev-sans-first:28.61 13:42:06 INFO - PROCESS | 16850 | Values: 87.0 87.0 141.0 87.0 87.0 88.0 142.0 87.0 88.0 150.0 13:42:06 INFO - PROCESS | 16850 | 13:42:06 INFO - PROCESS | 16850 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 13:42:06 INFO - PROCESS | 16850 | Values: 117.0 118.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 13:42:06 INFO - PROCESS | 16850 | 13:42:06 INFO - PROCESS | 16850 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 13:42:06 INFO - PROCESS | 16850 | Values: 145.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 13:42:06 INFO - PROCESS | 16850 | 13:42:06 INFO - PROCESS | 16850 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 13:42:06 INFO - PROCESS | 16850 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 94.0 94.0 13:42:06 INFO - PROCESS | 16850 | 13:42:06 INFO - PROCESS | 16850 | [#8] json-parse-financial Cycles:10 Average:66.70 Median:66.00 stddev:3.33 (5.1%) stddev-sans-first:3.48 13:42:06 INFO - PROCESS | 16850 | Values: 65.0 65.0 66.0 65.0 66.0 66.0 76.0 67.0 66.0 65.0 13:42:06 INFO - PROCESS | 16850 | 13:42:06 INFO - PROCESS | 16850 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 13:42:06 INFO - PROCESS | 16850 | Values: 65.0 65.0 65.0 66.0 65.0 65.0 66.0 64.0 65.0 66.0 13:42:06 INFO - PROCESS | 16850 | 13:42:06 INFO - PROCESS | 16850 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:83.50 stddev:4.48 (5.4%) stddev-sans-first:4.11 13:42:06 INFO - PROCESS | 16850 | Values: 92.0 83.0 82.0 84.0 91.0 83.0 83.0 82.0 93.0 83.0 13:42:06 INFO - PROCESS | 16850 | 13:42:06 INFO - PROCESS | 16850 | [#11] stanford-crypto-ccm Cycles:10 Average:139.00 Median:135.50 stddev:10.65 (7.9%) stddev-sans-first:11.19 13:42:06 INFO - PROCESS | 16850 | Values: 135.0 135.0 139.0 146.0 132.0 133.0 134.0 133.0 167.0 136.0 13:42:06 INFO - PROCESS | 16850 | 13:42:06 INFO - PROCESS | 16850 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.50 Median:173.00 stddev:2.88 (1.7%) stddev-sans-first:2.76 13:42:06 INFO - PROCESS | 16850 | Values: 176.0 177.0 171.0 173.0 172.0 170.0 173.0 172.0 174.0 167.0 13:42:06 INFO - PROCESS | 16850 | 13:42:06 INFO - PROCESS | 16850 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 13:42:06 INFO - PROCESS | 16850 | Values: 68.0 68.0 69.0 68.0 69.0 68.0 68.0 68.0 67.0 67.0 13:42:06 INFO - PROCESS | 16850 | -------- Summary: end -------- 13:42:06 INFO - PROCESS | 16850 | 13:42:07 INFO - TEST-INFO | 16850: exit 0 13:42:07 INFO - TEST-OK | kraken | took 64858ms 13:42:07 INFO - SUITE-END | took 1186s 13:42:07 INFO - Completed test suite (00:19:47) 13:42:07 INFO - javascript benchmark 13:42:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2568.7174410814805, 2587.767100960913, 2594.792416606671, 2605.517979173852, 2631.513170063537, 4428.047969686517, 4506.549345065492, 4567.429071366079, 4657.673962822608, 4719.858404247874, 4568.794404251808, 4598.678092533524, 4612.792424340904, 4622.191116554598, 4652.185867473196, 4157.708960372775, 4167.083241686824, 4242.575742425764, 4309.181255561433, 4365.519792822787, 4309.784510774464, 4317.11499142675, 4333.046729719473, 4336.046069864625, 4373.781310934441, 4147.751134931914, 4182.498100227992, 4185.874423767292, 4301.741895486281, 4322.265214913472, 4200.978995105005, 4202.789860506962, 4252.702310838243, 4262.957370426287, 4265.55211702773, 4150.813213405404, 4166.937495937564, 4171.770552619605, 4220.472440944882, 4269.551697071794, 4590.440720049659, 4604.884877878047, 4649.604783593399, 4657.813687452532, 4685.742284174369, 4863.562279394871, 4894.559489645949, 4942.851714448572, 4945.752712364368, 4949.0, 5003.274525193827, 5016.673916195436, 5018.347614810052, 5022.146235139999, 5076.720780357079, 4690.929636055462, 4700.2244629635725, 4701.388819453449, 4710.646701497401, 4712.387389639325, 4922.360093187863, 5016.072026675077, 5073.34046573943, 5086.440491545927, 5169.741512924339, 4885.60915126789, 4911.066897289504, 4914.459409464956, 4916.287138364917, 4974.37820272466, 4972.801087956441, 4984.252362145708, 4988.401391832931, 4991.925121123186, 4996.300517927493, 4749.572538471485, 4851.75741212945, 4892.315075889378, 4901.2893130496595, 4984.975075124601, 4925.852224433273, 4930.531599498114, 4934.5312195341385, 4937.136001199776, 4990.975045124751, 4246.299360605465, 4254.149170165979, 4257.127288905829, 4258.638015768633, 4306.354046892991, 3610.819459027038, 3632.219072899339, 3658.926821463556, 3688.188598508324, 3734.8879533614036, 4300.827966881289, 4312.611864932109, 4318.632916202095, 4361.193179261847, 4368.0, 4947.777350019258, 4961.677490963076, 4965.726885021359, 4980.277859710394, 5033.874153146201, 4136.855210067633, 4244.0663054128045, 4250.128723611714, 4284.228838809045, 4292.5063617683745, 4505.234110201273, 4520.638348932078, 4525.660575456854, 4571.771411429415, 4583.679142460062, 4727.479977202505, 4736.123817093849, 4737.24204127338, 4737.502562230985, 4800.927986080142, 4777.140114779373, 4877.463479017234, 4906.779194936165, 4914.5085491452, 4979.576735977483, 4651.325557794168, 4664.86005419838, 4666.440027196758, 4710.905781884275, 4721.150192965162, 4862.027594481188, 4862.07620552094, 4863.56227939473, 4869.659123861437, 4891.021795640815, 4804.375431193923, 4861.440934292602, 4872.610191184767, 4894.119058569349, 4934.062528119646, 4805.735684537244, 4826.034793041335, 4827.372441582572, 4851.95148048515, 4886.0, 4814.398200224972, 4815.30178124177, 4830.058138662927, 4839.733814640088, 4891.0, 4617.307403889444, 4699.530046995274, 4721.858344249678, 4738.099761045391, 4740.383750112601, 4803.663743537919, 4822.517748225149, 4827.806887724592, 4873.7806798694855, 4886.584640305614, 4706.1764191267075, 4725.976370118127, 4731.479537250831, 4732.337472753748, 4784.497627749036], "value": 4549.892643238123, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.1945836911588, 567.4070596226943, 572.367533875068, 573.7418161827176, 575.2062154227166, 28026.57960130597, 37184.25631487369, 38605.0, 38740.0, 42618.57381426192, 39581.0, 39668.60331396685, 39969.8001509992, 40058.599414005854, 40136.19727605446, 7530.8117297067465, 7661.23387661235, 7664.156942736295, 7674.501157424777, 7675.3092221700035, 7295.234000429958, 9561.0, 9859.161971232417, 9867.16129129025, 10171.338862973884, 9963.202943764481, 10066.496675166249, 10076.19390448766, 10076.244281678866, 10078.294519383646, 9834.852477212848, 9862.0, 9890.703278901645, 9904.603815847357, 9910.851337229948, 9506.904930950672, 9556.761080972961, 9558.474283914382, 9571.664991725256, 9573.808523829553, 36344.0, 36542.45186322207, 36555.08612284688, 36569.45145822815, 36587.0, 2971.940561188764, 3097.132802815215, 3186.9681303186903, 3385.830708464567, 3430.828458577086, 27683.0, 28060.158195254175, 28169.0, 28288.43423131526, 29609.703902961126, 3179.650238473766, 3187.8406079696156, 3202.1034110449114, 3241.33552621712, 3271.2966712156763, 177580.0, 178177.0, 178501.0, 178595.0, 178706.0, 30272.243193920327, 49230.50769492259, 49461.0, 49463.25805112926, 49536.50463495319, 31289.687103129134, 32654.51018234681, 32800.0, 32805.17987050343, 32818.34363312768, 12320.81518777219, 12440.0, 12442.0, 12455.377231138407, 12503.124781265406, 8985.281177505783, 9117.680881169259, 10280.742981425374, 10310.175185985103, 10435.426051567236, 7252.673629686677, 7316.085489313836, 7424.480286379901, 7674.53952762836, 7691.730789422343, 2961.8964875263746, 3009.7441717454262, 3034.0594415731193, 3040.6047213862057, 3059.586955760988, 813.5891374855778, 820.2904487618287, 852.2627926843236, 857.2070834478083, 857.562643052048, 25073.874630627095, 26216.344591384986, 26641.733582664314, 26903.327416814343, 27355.179344619693, 923.1645360948353, 942.9952850235842, 961.7499450142873, 967.3132076225818, 970.6214576315243, 13386.531471398454, 13820.654483637789, 14317.284135793168, 14424.927875360556, 14543.0, 382161.0, 447287.0, 451068.0, 452239.0, 680689.0, 47689.0, 48336.516634833904, 48356.5164348359, 48418.27372589414, 48449.75775121102, 1099.5436893689189, 1171.6367925942984, 1174.5888938871497, 1207.722223888493, 1208.3233389301843, 26137.6079358806, 29101.0, 29128.7087129126, 29161.125166245045, 29608.259793505335, 39520.0, 45259.54740452553, 46622.0, 46636.300455492514, 51320.0, 354275.17285166174, 357280.0, 357407.0, 357448.0, 357560.0, 23943.52112957766, 25046.123385681414, 38526.42210366791, 38871.41692874552, 39231.80384098061, 38838.6116138835, 39089.21821563496, 39234.803825980685, 39373.80313098416, 39464.210715784946, 33256.33487330288, 33852.83073584616, 33970.66029339675, 34164.658353417144, 34360.82819585886, 33150.5027424584, 33988.32023359568, 34010.65989340075, 34052.14869628279, 34363.31273374568, 33208.50187247145, 34083.05795659665, 34147.31705365829, 34149.0, 34375.31249375048, 29303.70696293095, 30358.69641303559, 30779.692203077684, 31115.533267001465, 31272.374552509278, 23907.11812043778, 24238.51522969566, 24240.87879560591, 24364.51270974606, 24724.13465528698], "value": 16479.294584930038, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.23124242288185, 366.8715949417704, 377.1250698379759, 378.445577229359, 386.87039841653046, 12868.420921058552, 16106.0, 16331.673366532663, 16684.165791710395, 17551.12244387782, 16734.916325418355, 16751.162441877917, 17447.73828392572, 17682.557936051606, 17758.0, 4850.611951043926, 4919.655624106314, 4990.226514890198, 5007.399112106552, 5014.548690617844, 3707.536557930259, 5009.649324547283, 5017.096922553938, 5512.614117011811, 5734.79928202513, 5793.942060579382, 5799.710014499279, 5810.070388737803, 5811.0702287633985, 5818.0, 5641.52047075997, 5793.826185214451, 5886.175935369051, 5908.793192238294, 5916.0, 5223.503767142115, 5223.6865788052455, 5227.947720522784, 5230.8169214077325, 5231.450697676765, 20448.284310049225, 20668.17327306906, 20770.376888693212, 20922.0, 21048.68426973581, 1835.3943198744516, 1985.076939223268, 2007.1770574064562, 2013.4563667809755, 2075.8962051897497, 12963.805542916863, 13425.328733563283, 13532.864671353258, 14038.789418158736, 14199.876027274087, 1650.645111301064, 1699.8555122814575, 1743.4159556548445, 1780.5103596510933, 1828.3052440072688, 64657.67671161661, 68160.0, 68697.3130268696, 68823.0, 69790.65104674496, 9548.0, 9729.805403891882, 9900.851487227697, 10077.949610252048, 10079.244056695778, 13351.866481335257, 13454.394552245172, 13455.25996070206, 13455.932720336335, 13464.124831885896, 7243.5653860768525, 7290.161631412456, 7325.670344834495, 7438.4049276057785, 7478.364339031244, 6733.528652994243, 6900.965495172492, 7083.114610673666, 7098.219195888448, 7102.254263302382, 6054.545909056838, 6221.2845522765465, 6271.372862713783, 6290.654014029181, 6298.338674439118, 1733.6706025855046, 1752.4567384110967, 1765.1086201468434, 1775.14792899409, 1776.7917815885064, 850.2432834777053, 852.1648784191403, 857.4298091769028, 889.0442774017956, 900.1943260781563, 17104.657906841792, 17397.043162625923, 17871.73192402115, 17936.820631793777, 18035.0, 842.6123982967904, 852.953087580189, 885.6368888755579, 902.5622573052065, 936.1434287626881, 9474.289428292906, 9971.950140249397, 10070.244731645156, 10105.191584673208, 10232.897671023344, 383043.0, 389577.0, 390959.0, 401461.0, 402064.0, 69235.65382173158, 69473.0, 70000.64999675071, 71954.64022679852, 72877.6356118216, 885.7608445719619, 918.2975024106564, 928.5867788834039, 936.0779632062413, 937.5218638494417, 15716.60708482297, 16033.599160021093, 16354.264058117174, 16384.525392714713, 16505.917470412573, 37499.625003749614, 38507.229855402176, 38566.0, 39192.0, 39251.803740981115, 49987.0, 50234.49765502445, 53720.0, 54833.451665484434, 55087.724561376934, 7728.908436625395, 7756.92243077562, 7874.13384527713, 7887.487313324616, 8025.638846251816, 11868.287902725864, 11872.347020913932, 12002.159848810848, 12137.635870923887, 12440.377981100728, 9480.715578532656, 9930.155936745457, 10094.031663825484, 10161.136303414292, 10320.380777153396, 10295.794084118126, 10507.579696812041, 10612.628558000433, 10622.36265824053, 10755.354678719303, 9874.75313117149, 9982.850257246293, 10173.186145108522, 10460.110890574386, 10462.63380781669, 7494.475386723095, 7721.420893433127, 7769.805754856174, 7770.14528401864, 7812.218778122142, 8847.292216622525, 9954.303198776017, 10055.346402483816, 10135.49322533885, 10444.268901177149], "value": 8413.657161180614, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1253.6991122130692, 1327.9203247805133, 1379.599916024353, 1415.3277193333167, 1630.7553866919968, 7310.0, 7637.732679356223, 7645.235476452352, 7688.461807673465, 7700.3454706349885, 7566.735164269252, 7673.501222420538, 7694.576798276093, 7697.191794861543, 7698.0, 2152.3973287479494, 2179.607670619288, 2182.9126834926665, 2183.727034120735, 2186.4424571734266, 2083.906224219906, 2115.5874604452138, 2167.5773224221284, 2177.5536015116863, 2179.9128034878586, 2125.2880285104507, 2139.0, 2145.0240140736005, 2147.0552956699003, 2174.412908514708, 2115.925942592002, 2120.4486833423266, 2121.5438680683574, 2122.1405330841035, 2124.192806733447, 2053.9281125160696, 2118.4915620251027, 2129.2866889592005, 2129.6699011653063, 2132.605467988427, 7588.051493563305, 7689.9615501922135, 7703.768886933401, 7773.416993725493, 7775.0, 4302.741835489881, 4477.328400739882, 4478.753668548228, 4483.08096840147, 4485.753283569403, 2843.516602177614, 2958.5118455454826, 2988.2678743707716, 2999.3851260491547, 3005.6994300569986, 925.3892430995578, 926.5274709898, 944.7968686732316, 960.870282511866, 962.3552220012539, 9942.950285248528, 9970.651027214086, 9998.80002399948, 10009.59961601535, 10038.598456061822, 4027.7381970171846, 4086.0, 4101.671866250693, 4109.8972525687095, 4179.226843034048, 8019.318357939641, 8046.517208967481, 8048.839023219502, 8049.55727434985, 8064.395170362129, 4335.328024156261, 4343.457067866517, 4350.282203436397, 4358.433403657505, 4385.342198670161, 3519.1202199450136, 3971.3645816669195, 3994.9201015979515, 4011.538673052578, 4130.855420060284, 3287.6219234787827, 3331.217163966466, 3419.982900085484, 3436.810975396377, 3437.9484307735406, 990.6730778843108, 1008.5461542305992, 1022.892596277395, 1032.939286124187, 1033.2767063055892, 827.1893544326593, 832.9042160151539, 835.7701632051235, 844.0968164064392, 860.4407135362064, 5274.657147285414, 5311.442298558673, 5375.919361209585, 5496.862578435571, 5657.43425657431, 424.974501529903, 430.9310510318334, 437.22610978568395, 438.52420124165, 440.4186473854545, 3633.8364773585254, 3679.1354031802507, 3696.5933747287777, 3730.403135498307, 3764.435334699817, 9308.115729005734, 9800.166985806287, 9803.950980245054, 9840.081184169161, 9865.210783137332, 9722.416655000581, 9725.610975560898, 9747.415155090717, 9756.90243097574, 9757.316987810927, 7264.891026634605, 7372.963135184397, 7374.52065615744, 7380.77857664271, 7382.630868456663, 5294.417614062527, 5333.893322133458, 5445.50990410865, 5466.91799622998, 5578.693171875586, 8757.824843502967, 8989.595468203815, 9014.459132452073, 9049.683261085831, 9082.954585227297, 9090.772730681785, 9097.09029097085, 9144.862827057732, 9150.588223529823, 9152.725418237464, 5835.94164058371, 6590.80227593173, 6654.467642588678, 6658.500612454182, 6659.866802664016, 6833.077534532775, 6948.965255173692, 6974.058502102354, 7443.627818609156, 7506.3244308012545, 6626.635535045619, 6700.6984685688285, 6734.8653026940165, 6747.763828265987, 6797.150356205474, 6508.284088750328, 6548.345165483413, 6557.639329836905, 6576.539642224999, 6627.105340778933, 6368.426841584094, 6480.0, 6491.415772580491, 6494.772682956074, 6504.544681872224, 4591.586757191869, 4616.561426664462, 4639.280911458729, 4737.620990320697, 4866.853994380174, 4627.421572303462, 4650.348951146774, 4692.906141877212, 4727.078219747116, 4817.8313759018265], "value": 3994.9919635855804, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.2750996304074, 304.14231866137493, 309.9736522395596, 311.1055714819892, 312.79199332443926, 4598.97700511497, 4739.857804265869, 4756.429228492577, 4804.2073057945445, 4805.735684537349, 4576.610988066019, 4673.813047478096, 4694.882627934303, 4703.647226458021, 4713.528647135293, 3742.9438558421643, 3745.325841348556, 3751.08098515864, 3753.756005859624, 3755.1550901047317, 3581.426971684531, 3646.781193128421, 3747.775133491999, 3757.6993840492833, 3772.302124107049, 3708.1100535871333, 3726.1988672435423, 3731.6641502264793, 3736.8505259789576, 3738.6448287412786, 3711.9072023199365, 3712.70055480581, 3718.2749363874054, 3722.40441529354, 3728.403455447129, 3301.4552598821165, 3302.256992176741, 3307.4708046712412, 3309.7517686173633, 3320.5185248138882, 4460.576245256695, 4590.173768721629, 4623.53764623535, 4640.350350950869, 4645.814167433298, 4223.387608796707, 4243.61807437329, 4244.342126970325, 4252.702310838243, 4264.9147017059795, 4925.109163760625, 4926.950730492685, 4932.901341973176, 4938.604911607063, 4950.9009819803405, 3384.4415671414185, 3502.176988407722, 3615.421532554805, 3619.60184379718, 3631.7457777955556, 5145.742712864342, 5156.484351564851, 5161.66449180802, 5191.131192770599, 5198.298229738974, 3536.840842162109, 3555.3244883472057, 3555.67103547177, 3556.76881002734, 3557.3418917500344, 3585.9421470666216, 3608.8195590220384, 3609.7112231021456, 3619.8914032578537, 3620.3664358737115, 3984.6812255019527, 4153.522344930311, 4173.52004519478, 4202.747835129902, 4207.852725154605, 5001.399832020181, 5010.874728131826, 5013.222950442687, 5014.272930425068, 5029.597632189416, 1217.8903898648987, 1233.6052463211865, 1253.931033793132, 1264.1782841153324, 1272.096811264013, 836.2766207230824, 846.5851732650957, 857.3068190324185, 861.237804542984, 862.1421685423044, 4354.651627869763, 4358.716683415568, 4360.302351623725, 4385.407969924019, 4393.450818647669, 5034.194528875362, 5064.11378008847, 5067.569256613156, 5077.39071311445, 5077.771500282496, 4368.2355587772645, 4368.410264614236, 4368.978155109204, 4372.825086996548, 4395.582419670126, 2273.715785526809, 2352.847064940773, 2360.3273067176115, 2400.6519054737314, 2409.217004473553, 4284.271673815459, 4303.139372125587, 4307.698461107692, 4313.913721725611, 4331.350297455344, 4584.587387135174, 4611.377464042312, 4622.607078398307, 4648.86053418398, 4653.697509661861, 4239.876432745264, 4304.612584867377, 4477.485089214717, 4819.542143496362, 4871.0, 5119.334486516729, 5125.79496820123, 5126.256692779451, 5127.154019586876, 5129.204973229155, 5043.798248070036, 5068.2904393384215, 5071.416787069535, 5072.351485767067, 5085.618578606545, 4658.417697787777, 4845.733484658378, 4857.1742803724155, 4878.756062196805, 4896.706197628154, 3643.690286325692, 3652.6895213906055, 3660.066682995819, 3666.2300916807767, 3677.705783537364, 5098.260752190986, 5134.152864777419, 5140.151874940593, 5154.948450515447, 5175.266285794301, 4824.589909857701, 4830.661853670209, 4890.9021819562695, 4908.263760435963, 4935.383077115361, 4957.652964292465, 4960.801567937242, 4972.0, 4984.4517103117905, 4986.63135010867, 4811.879703007313, 4909.533594308535, 4922.941567562991, 4945.2582112683385, 4948.529889660476, 4989.226669866177, 4993.6254780892305, 5006.07387633289, 5012.77442515095, 5017.745563609098, 4897.41231052276, 4899.191633380452, 4903.362562866804, 4906.8714195734465, 4914.754262286943], "value": 3708.444516231501, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [632.9587081661642, 705.7388766156523, 728.6575309604484, 730.9415246780255, 739.3198257603004, 13386.531471398503, 14560.635984100389, 14634.560963171096, 14724.6318842029, 14786.260686965648, 13327.46690132396, 13414.530491432803, 13462.192268463874, 13465.865341346584, 13469.797953030713, 737.1044181319695, 744.1293686386927, 762.8054846014259, 762.9923700762977, 764.4343186042345, 755.3428517190025, 756.0473803008222, 756.1191212237736, 756.6141267953356, 757.2049348184412, 798.5807451088167, 800.2877439079224, 800.3437181511163, 800.403699244064, 801.1067659559578, 789.1319548496665, 790.6837265093951, 791.2087912087912, 791.3550456378091, 792.4096548071694, 583.547750493371, 584.0392554248238, 584.2492397269531, 584.5498965796313, 585.4818485640196, 12640.241585504898, 12714.554990575378, 12773.552925647651, 12776.0, 12792.296423696693, 12420.441080151415, 12653.0, 12809.167404118702, 12885.291308978003, 13030.413631386611, 9833.31166818323, 9897.604095836157, 9968.302218844683, 9985.800283994353, 10045.79908401828, 3213.887513937001, 3255.1699316674335, 3262.2333751568362, 3312.602487701491, 3418.8119653419053, 42448.57551424508, 48157.0, 51534.0, 66180.66909665469, 67778.3222167782, 10229.386236825814, 10233.283670143168, 10272.280940334254, 10338.12125969301, 10444.63443779464, 17822.10889455548, 17826.821731782777, 17829.10854457272, 17868.46394608164, 17889.105544722974, 5101.9744901276, 6966.477514186457, 6977.9994602321485, 6983.441324694012, 6999.860002800017, 3706.1661126246377, 3788.7726736395903, 3820.751651142667, 3822.5604055533413, 3982.960170398259, 2903.5499497577907, 3074.031680020786, 3079.276370053036, 3080.029790615949, 3081.0, 522.3496746550493, 525.4430303877901, 526.4630077321111, 538.0879409401027, 543.5515699547889, 488.9193283108247, 615.230961298377, 632.8196464007735, 646.1858058845888, 657.0505619380045, 7970.84058318842, 8225.300849427866, 8516.361272904556, 8911.821763564822, 8941.37410381267, 606.9544784141119, 610.3255902228063, 611.5382885921101, 618.5484596244677, 625.4714766022704, 4037.37420699792, 4259.574042595716, 4262.595053469915, 4287.957120428819, 4369.934450983238, 77087.0, 77714.0, 93305.5334723322, 96204.0, 96724.0, 77907.0, 84633.57683211545, 87964.5601771987, 90940.54529727309, 96691.0, 77820.22179778243, 78642.6067869657, 78726.6063669678, 80787.59606202049, 80791.59604201942, 8960.0, 9237.584308706259, 9340.392874463138, 9396.154346108882, 9512.571934262836, 28571.14286571406, 28597.85701071481, 31439.84280078585, 38139.61860381471, 39588.80205598954, 36049.27901442009, 36239.637603623625, 48184.036319272716, 52406.47593524016, 54007.97896273617, 12614.0, 12851.485940562272, 12882.867262774478, 13128.540501082416, 13390.062695611214, 13528.39122239482, 13585.32073396346, 13635.727285454434, 14126.364313606118, 14818.036827606602, 12806.551770687982, 12950.287734174712, 13075.917927643079, 13212.933935330646, 14209.857901420854, 10921.945390272998, 11042.668719938414, 11131.777364452828, 11270.211085224284, 11325.490352933974, 11730.824037639271, 12780.552680656132, 12784.488620455078, 12894.226346419246, 12963.481460741465, 10045.347052441568, 10288.228382871164, 10370.896291036994, 10396.116330111723, 10843.512041957973, 9876.950615246878, 9966.302358835102, 10087.69736907894, 10105.848412273675, 10154.035366640157], "value": 6564.95630287463, "unit": "score"}], "name": "dromaeo_css", "value": 6280.377725833206, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 129.0, 113.0, 114.0, 114.0, 113.0, 114.0, 114.0, 113.0], "value": 115.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 123.0, 160.0, 196.0, 125.0, 151.0, 150.0, 131.0, 179.0, 122.0], "value": 149.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 163.0, 160.0, 165.0, 164.0, 163.0, 161.0, 163.0, 162.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 166.0, 76.0, 77.0, 76.0, 76.0, 178.0, 77.0], "value": 95.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 141.0, 87.0, 87.0, 88.0, 142.0, 87.0, 88.0, 150.0], "value": 104.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 94.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 65.0, 66.0, 66.0, 76.0, 67.0, 66.0, 65.0], "value": 66.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 66.0, 65.0, 65.0, 66.0, 64.0, 65.0, 66.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 83.0, 82.0, 84.0, 91.0, 83.0, 83.0, 82.0, 93.0, 83.0], "value": 85.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 135.0, 139.0, 146.0, 132.0, 133.0, 134.0, 133.0, 167.0, 136.0], "value": 139.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 177.0, 171.0, 173.0, 172.0, 170.0, 173.0, 172.0, 174.0, 167.0], "value": 172.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 69.0, 68.0, 69.0, 68.0, 68.0, 68.0, 67.0, 67.0], "value": 68.0, "unit": "score"}], "name": "kraken", "value": 1581.2, "alertThreshold": 2.0}]} 13:42:07 INFO - Return code: 0 13:42:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:42:07 INFO - # TBPL SUCCESS # 13:42:07 INFO - Running post-action listener: _resource_record_post_action 13:42:07 INFO - [mozharness: 2016-08-25 20:42:07.813886Z] Finished run-tests step (success) 13:42:07 INFO - Running post-run listener: _resource_record_post_run 13:42:07 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 406339584; Read time: 20; Write time: 327192 13:42:07 INFO - TinderboxPrint: CPU usage
13.0% 13:42:07 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 13:42:07 INFO - TinderboxPrint: I/O write bytes / time
406,339,584 / 327,192 13:42:07 INFO - TinderboxPrint: CPU idle
8,347.2 (87.0%) 13:42:07 INFO - TinderboxPrint: CPU user
1,201.4 (12.5%) 13:42:07 INFO - TinderboxPrint: Swap in / out
0 / 0 13:42:07 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 113512448; Read time: 0; Write time: 102876 13:42:07 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 292827136; Read time: 0; Write time: 224316 13:42:08 INFO - Running post-run listener: _upload_blobber_files 13:42:08 INFO - Blob upload gear active. 13:42:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:42:08 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:42:08 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'] 13:42:08 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 13:42:08 INFO - (blobuploader) - INFO - Open directory for files ... 13:42:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:42:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:42:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:42:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:42:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:42:10 INFO - (blobuploader) - INFO - Done attempting. 13:42:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:42:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:42:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:42:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:42:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:42:11 INFO - (blobuploader) - INFO - Done attempting. 13:42:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:42:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:42:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:42:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:42:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:42:19 INFO - (blobuploader) - INFO - Done attempting. 13:42:19 INFO - (blobuploader) - INFO - Iteration through files over. 13:42:19 INFO - Return code: 0 13:42:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:42:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:42:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/724fff04434e3e83d759da363c4d4df2c6ce4fcdbb3d597687a94eeddd76a0ca502b27b766b052ce9e5d7e7a99834a3ae880a5f06046ae38b71b585a72387218", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f02222799679e557826daa5c3f3cfece23f2597a95410d7c3b4512d6ebc9bd467786911aadb228833a7ee2704b49d79357387d1d6663e84da04a1c4810bf3f29", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5de8ab50d0d99ea8f7247f20396858878389d0ceebaadc6ca283687b6a22de163b5aeee31ae34de3ac51ff6c1fd676a669971af7f778c8a64b3dc4cb7fc182b0"} 13:42:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:42:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:42:19 INFO - Contents: 13:42:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/724fff04434e3e83d759da363c4d4df2c6ce4fcdbb3d597687a94eeddd76a0ca502b27b766b052ce9e5d7e7a99834a3ae880a5f06046ae38b71b585a72387218", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f02222799679e557826daa5c3f3cfece23f2597a95410d7c3b4512d6ebc9bd467786911aadb228833a7ee2704b49d79357387d1d6663e84da04a1c4810bf3f29", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5de8ab50d0d99ea8f7247f20396858878389d0ceebaadc6ca283687b6a22de163b5aeee31ae34de3ac51ff6c1fd676a669971af7f778c8a64b3dc4cb7fc182b0"} 13:42:19 INFO - Running post-run listener: copy_logs_to_upload_dir 13:42:19 INFO - Copying logs to upload dir... 13:42:19 INFO - mkdir: /builds/slave/test/build/upload/logs 13:42:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.910145 ========= master_lag: 0.34 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-08-25 13:42:19.500219) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-25 13:42:19.504525) ========= 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=14ef55db36f7623abb31b9cf000001d5-1472156485.619106-482549871 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/724fff04434e3e83d759da363c4d4df2c6ce4fcdbb3d597687a94eeddd76a0ca502b27b766b052ce9e5d7e7a99834a3ae880a5f06046ae38b71b585a72387218", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f02222799679e557826daa5c3f3cfece23f2597a95410d7c3b4512d6ebc9bd467786911aadb228833a7ee2704b49d79357387d1d6663e84da04a1c4810bf3f29", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5de8ab50d0d99ea8f7247f20396858878389d0ceebaadc6ca283687b6a22de163b5aeee31ae34de3ac51ff6c1fd676a669971af7f778c8a64b3dc4cb7fc182b0"} build_url:https://queue.taskcluster.net/v1/task/PmjOhxdCQ1OTV7Z3BPuKtw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011302 build_url: 'https://queue.taskcluster.net/v1/task/PmjOhxdCQ1OTV7Z3BPuKtw/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/724fff04434e3e83d759da363c4d4df2c6ce4fcdbb3d597687a94eeddd76a0ca502b27b766b052ce9e5d7e7a99834a3ae880a5f06046ae38b71b585a72387218", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f02222799679e557826daa5c3f3cfece23f2597a95410d7c3b4512d6ebc9bd467786911aadb228833a7ee2704b49d79357387d1d6663e84da04a1c4810bf3f29", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5de8ab50d0d99ea8f7247f20396858878389d0ceebaadc6ca283687b6a22de163b5aeee31ae34de3ac51ff6c1fd676a669971af7f778c8a64b3dc4cb7fc182b0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-25 13:42:19.533099) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 13:42:19.533523) ========= 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=14ef55db36f7623abb31b9cf000001d5-1472156485.619106-482549871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004448 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 13:42:19.586279) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-25 13:42:19.586690) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-25 13:42:19.587059) ========= ========= Total master_lag: 0.47 =========