builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-028 starttime: 1472300771.52 results: success (0) buildid: 20160827023002 builduid: 050b6bd4997146e6a992efa36601cf56 revision: 087a40f5eaa909ceea0d41f0357c50ee3df47a4d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-27 05:26:11.516475) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-27 05:26:11.517074) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-27 05:26:11.517347) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-27 05:26:11.582167) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 05:26:11.582423) ========= 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=836cfdc75598d54cb747368e000001a9-1472300097.879568-1396000819 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-27 05:26:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 33.5M=0s 2016-08-27 05:26:12 (33.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.184432 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 05:26:11.781213) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 05:26:11.781506) ========= 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=836cfdc75598d54cb747368e000001a9-1472300097.879568-1396000819 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017923 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 05:26:11.830587) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 05:26:11.830891) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 087a40f5eaa909ceea0d41f0357c50ee3df47a4d --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 087a40f5eaa909ceea0d41f0357c50ee3df47a4d --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=836cfdc75598d54cb747368e000001a9-1472300097.879568-1396000819 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-27 05:26:13,021 truncating revision to first 12 chars 2016-08-27 05:26:13,021 Setting DEBUG logging. 2016-08-27 05:26:13,021 attempt 1/10 2016-08-27 05:26:13,021 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/087a40f5eaa9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-27 05:26:13,286 unpacking tar archive at: fx-team-087a40f5eaa9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.603631 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 05:26:12.450198) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-27 05:26:12.450547) ========= script_repo_revision: 087a40f5eaa909ceea0d41f0357c50ee3df47a4d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-27 05:26:12.450921) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-27 05:26:12.451202) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-27 05:26:12.464437) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-08-27 05:26:12.464703) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=836cfdc75598d54cb747368e000001a9-1472300097.879568-1396000819 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:26:13 INFO - MultiFileLogger online at 20160827 05:26:13 in /builds/slave/test 05:26:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:26:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:26:13 INFO - {'append_to_log': False, 05:26:13 INFO - 'base_work_dir': '/builds/slave/test', 05:26:13 INFO - 'blob_upload_branch': 'Fx-Team', 05:26:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:26:13 INFO - 'branch': 'Fx-Team', 05:26:13 INFO - 'buildbot_json_path': 'buildprops.json', 05:26:13 INFO - 'config_files': ('talos/linux_config.py',), 05:26:13 INFO - 'default_actions': ('clobber', 05:26:13 INFO - 'read-buildbot-config', 05:26:13 INFO - 'download-and-extract', 05:26:13 INFO - 'populate-webroot', 05:26:13 INFO - 'create-virtualenv', 05:26:13 INFO - 'install', 05:26:13 INFO - 'run-tests'), 05:26:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:26:13 INFO - 'download_minidump_stackwalk': True, 05:26:13 INFO - 'download_symbols': 'ondemand', 05:26:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:26:13 INFO - 'tooltool.py': '/tools/tooltool.py', 05:26:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:26:13 INFO - '/tools/misc-python/virtualenv.py')}, 05:26:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:26:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:26:13 INFO - 'installer_path': 'installer.exe', 05:26:13 INFO - 'log_level': 'info', 05:26:13 INFO - 'log_name': 'talos', 05:26:13 INFO - 'log_to_console': True, 05:26:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:26:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:26:13 INFO - 'opt_config_files': (), 05:26:13 INFO - 'pip_index': False, 05:26:13 INFO - 'sps_profile': False, 05:26:13 INFO - 'sps_profile_interval': 0, 05:26:13 INFO - 'suite': 'dromaeojs', 05:26:13 INFO - 'system_bits': '32', 05:26:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:26:13 INFO - 'title': 'talos-linux64-ix-028', 05:26:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:26:13 INFO - 'use_talos_json': True, 05:26:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:26:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:26:13 INFO - 'work_dir': 'build'} 05:26:13 INFO - [mozharness: 2016-08-27 12:26:13.746622Z] Running clobber step. 05:26:13 INFO - Running pre-action listener: _resource_record_pre_action 05:26:13 INFO - Running main action method: clobber 05:26:13 INFO - rmtree: /builds/slave/test/build 05:26:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:26:14 INFO - Running post-action listener: _resource_record_post_action 05:26:14 INFO - [mozharness: 2016-08-27 12:26:14.211186Z] Finished clobber step (success) 05:26:14 INFO - [mozharness: 2016-08-27 12:26:14.211288Z] Running read-buildbot-config step. 05:26:14 INFO - Running pre-action listener: _resource_record_pre_action 05:26:14 INFO - Running main action method: read_buildbot_config 05:26:14 INFO - Using buildbot properties: 05:26:14 INFO - { 05:26:14 INFO - "project": "", 05:26:14 INFO - "product": "firefox", 05:26:14 INFO - "script_repo_revision": "production", 05:26:14 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:26:14 INFO - "repository": "", 05:26:14 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:26:14 INFO - "buildid": "20160827023002", 05:26:14 INFO - "pgo_build": "True", 05:26:14 INFO - "basedir": "/builds/slave/test", 05:26:14 INFO - "buildnumber": 401, 05:26:14 INFO - "slavename": "talos-linux64-ix-028", 05:26:14 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:26:14 INFO - "platform": "ubuntu64_hw", 05:26:14 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:26:14 INFO - "branch": "fx-team", 05:26:14 INFO - "repo_path": "integration/fx-team", 05:26:14 INFO - "revision": "087a40f5eaa909ceea0d41f0357c50ee3df47a4d", 05:26:14 INFO - "stage_platform": "linux64-pgo", 05:26:14 INFO - "builduid": "050b6bd4997146e6a992efa36601cf56", 05:26:14 INFO - "slavebuilddir": "test" 05:26:14 INFO - } 05:26:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/JdZOMC-nQk-582FFdTeoEw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 05:26:14 INFO - Running post-action listener: _resource_record_post_action 05:26:14 INFO - [mozharness: 2016-08-27 12:26:14.213765Z] Finished read-buildbot-config step (success) 05:26:14 INFO - [mozharness: 2016-08-27 12:26:14.213857Z] Running download-and-extract step. 05:26:14 INFO - Running pre-action listener: _resource_record_pre_action 05:26:14 INFO - Running main action method: download_and_extract 05:26:14 INFO - mkdir: /builds/slave/test/build/tests 05:26:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:14 INFO - trying https://queue.taskcluster.net/v1/task/JdZOMC-nQk-582FFdTeoEw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:26:14 INFO - Downloading https://queue.taskcluster.net/v1/task/JdZOMC-nQk-582FFdTeoEw/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 05:26:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JdZOMC-nQk-582FFdTeoEw/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 05:26:14 INFO - Downloaded 1361 bytes. 05:26:14 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:26:14 INFO - Using the following test package requirements: 05:26:14 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:26:14 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:26:14 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:26:14 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:26:14 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:26:14 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:26:14 INFO - u'jsshell-linux-x86_64.zip'], 05:26:14 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:26:14 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:26:14 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:26:14 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:26:14 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:26:14 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:26:14 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:26:14 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:26:14 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:26:14 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:26:14 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:26:14 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:26:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:14 INFO - trying https://queue.taskcluster.net/v1/task/JdZOMC-nQk-582FFdTeoEw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:26:14 INFO - Downloading https://queue.taskcluster.net/v1/task/JdZOMC-nQk-582FFdTeoEw/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 05:26:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JdZOMC-nQk-582FFdTeoEw/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 05:26:15 INFO - Downloaded 21875528 bytes. 05:26:15 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 05:26:19 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 05:26:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:19 INFO - trying https://queue.taskcluster.net/v1/task/JdZOMC-nQk-582FFdTeoEw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:26:19 INFO - Downloading https://queue.taskcluster.net/v1/task/JdZOMC-nQk-582FFdTeoEw/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 05:26:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JdZOMC-nQk-582FFdTeoEw/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 05:26:20 INFO - Downloaded 21875528 bytes. 05:26:20 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 05:26:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:25 INFO - trying https://queue.taskcluster.net/v1/task/JdZOMC-nQk-582FFdTeoEw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:26:25 INFO - Downloading https://queue.taskcluster.net/v1/task/JdZOMC-nQk-582FFdTeoEw/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 05:26:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JdZOMC-nQk-582FFdTeoEw/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 05:26:26 INFO - Downloaded 14413998 bytes. 05:26:26 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 05:26:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:26 INFO - trying https://queue.taskcluster.net/v1/task/JdZOMC-nQk-582FFdTeoEw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:26:26 INFO - Downloading https://queue.taskcluster.net/v1/task/JdZOMC-nQk-582FFdTeoEw/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 05:26:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JdZOMC-nQk-582FFdTeoEw/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 05:26:27 INFO - Downloaded 59703303 bytes. 05:26:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JdZOMC-nQk-582FFdTeoEw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:26:27 INFO - mkdir: /builds/slave/test/properties 05:26:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:26:27 INFO - Writing to file /builds/slave/test/properties/build_url 05:26:27 INFO - Contents: 05:26:27 INFO - build_url:https://queue.taskcluster.net/v1/task/JdZOMC-nQk-582FFdTeoEw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:26:28 INFO - Running post-action listener: _resource_record_post_action 05:26:28 INFO - Running post-action listener: set_extra_try_arguments 05:26:28 INFO - [mozharness: 2016-08-27 12:26:28.145565Z] Finished download-and-extract step (success) 05:26:28 INFO - [mozharness: 2016-08-27 12:26:28.145800Z] Running populate-webroot step. 05:26:28 INFO - Running pre-action listener: _resource_record_pre_action 05:26:28 INFO - Running main action method: populate_webroot 05:26:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:26:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:26:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:26:28 INFO - '--tppagecycles', 05:26:28 INFO - '7'], 05:26:28 INFO - 'tests': ['tsvgm']}}, 05:26:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:26:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:26:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:26:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:26:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:26:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:26:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:28 INFO - 'talos_options': ['--disable-e10s'], 05:26:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:26:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:26:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:28 INFO - 'talos_options': ['--disable-e10s'], 05:26:28 INFO - 'tests': ['damp', 'tps']}, 05:26:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:28 INFO - 'tests': ['damp', 'tps']}, 05:26:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:26:28 INFO - 'tests': ['dromaeo_dom']}, 05:26:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:26:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:26:28 INFO - 'tests': ['basic_compositor_video']}, 05:26:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:26:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:26:28 INFO - 'tests': ['a11yr', 05:26:28 INFO - 'ts_paint', 05:26:28 INFO - 'tpaint', 05:26:28 INFO - 'sessionrestore', 05:26:28 INFO - 'sessionrestore_no_auto_restore', 05:26:28 INFO - 'tabpaint']}, 05:26:28 INFO - 'other-e10s': {'tests': ['a11yr', 05:26:28 INFO - 'ts_paint', 05:26:28 INFO - 'tpaint', 05:26:28 INFO - 'sessionrestore', 05:26:28 INFO - 'sessionrestore_no_auto_restore', 05:26:28 INFO - 'tabpaint']}, 05:26:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:26:28 INFO - 'ts_paint', 05:26:28 INFO - 'tpaint', 05:26:28 INFO - 'sessionrestore', 05:26:28 INFO - 'sessionrestore_no_auto_restore', 05:26:28 INFO - 'tabpaint']}, 05:26:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:26:28 INFO - 'ts_paint', 05:26:28 INFO - 'tpaint', 05:26:28 INFO - 'sessionrestore', 05:26:28 INFO - 'sessionrestore_no_auto_restore', 05:26:28 INFO - 'tabpaint']}, 05:26:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:26:28 INFO - 'tests': ['a11yr', 05:26:28 INFO - 'ts_paint', 05:26:28 INFO - 'tpaint', 05:26:28 INFO - 'sessionrestore', 05:26:28 INFO - 'sessionrestore_no_auto_restore', 05:26:28 INFO - 'tabpaint']}, 05:26:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:26:28 INFO - 'tests': ['a11yr', 05:26:28 INFO - 'ts_paint', 05:26:28 INFO - 'tpaint', 05:26:28 INFO - 'sessionrestore', 05:26:28 INFO - 'sessionrestore_no_auto_restore', 05:26:28 INFO - 'tabpaint']}, 05:26:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:26:28 INFO - 'tests': ['tsvgx', 05:26:28 INFO - 'tsvgr_opacity', 05:26:28 INFO - 'tart', 05:26:28 INFO - 'tscrollx', 05:26:28 INFO - 'cart']}, 05:26:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:26:28 INFO - 'tsvgr_opacity', 05:26:28 INFO - 'tart', 05:26:28 INFO - 'tscrollx', 05:26:28 INFO - 'cart']}, 05:26:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:28 INFO - 'talos_options': ['--disable-e10s'], 05:26:28 INFO - 'tests': ['tp5o']}, 05:26:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:28 INFO - 'tests': ['tp5o']}, 05:26:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:28 INFO - 'talos_options': ['--disable-e10s', 05:26:28 INFO - '--xperf_path', 05:26:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:26:28 INFO - 'tests': ['tp5n']}, 05:26:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:28 INFO - 'talos_options': ['--xperf_path', 05:26:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:26:28 INFO - 'tests': ['tp5n']}}, 05:26:28 INFO - 'talos.zip': {'path': '', 05:26:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:26:28 INFO - Running post-action listener: _resource_record_post_action 05:26:28 INFO - [mozharness: 2016-08-27 12:26:28.166634Z] Finished populate-webroot step (success) 05:26:28 INFO - [mozharness: 2016-08-27 12:26:28.166724Z] Running create-virtualenv step. 05:26:28 INFO - Running pre-action listener: _resource_record_pre_action 05:26:28 INFO - Running main action method: create_virtualenv 05:26:28 INFO - Creating virtualenv /builds/slave/test/build/venv 05:26:28 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 05:26:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:26:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:26:28 INFO - Using real prefix '/usr' 05:26:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:26:28 INFO - Installing distribute.............................................................................................................................................................................................done. 05:26:30 INFO - Installing pip.................done. 05:26:30 INFO - Return code: 0 05:26:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:26:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7045738f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199d370>, '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 0x19a08f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a0d80>, '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': '836cfdc75598d54cb747368e000001a9-1472300097.879568-1396000819', '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 05:26:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:26:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:26:30 INFO - Using env: {'DISPLAY': ':0', 05:26:30 INFO - 'HOME': '/home/cltbld', 05:26:30 INFO - 'LANG': 'en_US.UTF-8', 05:26:30 INFO - 'LANGUAGE': 'en_US:en', 05:26:30 INFO - 'LOGNAME': 'cltbld', 05:26:30 INFO - 'MAIL': '/var/mail/cltbld', 05:26:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:30 INFO - 'MOZ_NO_REMOTE': '1', 05:26:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:30 INFO - 'NO_EM_RESTART': '1', 05:26:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:30 INFO - 'PWD': '/builds/slave/test', 05:26:30 INFO - 'SHELL': '/bin/bash', 05:26:30 INFO - 'SHLVL': '1', 05:26:30 INFO - 'TERM': 'linux', 05:26:30 INFO - 'TMOUT': '86400', 05:26:30 INFO - 'USER': 'cltbld', 05:26:30 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1472300097.879568-1396000819', 05:26:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:30 INFO - '_': '/tools/buildbot/bin/python'} 05:26:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:30 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 05:26:30 INFO - Cleaning up... 05:26:30 INFO - Return code: 0 05:26:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:26:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7045738f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199d370>, '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 0x19a08f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a0d80>, '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': '836cfdc75598d54cb747368e000001a9-1472300097.879568-1396000819', '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 05:26:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:26:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:26:30 INFO - Using env: {'DISPLAY': ':0', 05:26:30 INFO - 'HOME': '/home/cltbld', 05:26:30 INFO - 'LANG': 'en_US.UTF-8', 05:26:30 INFO - 'LANGUAGE': 'en_US:en', 05:26:30 INFO - 'LOGNAME': 'cltbld', 05:26:30 INFO - 'MAIL': '/var/mail/cltbld', 05:26:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:30 INFO - 'MOZ_NO_REMOTE': '1', 05:26:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:30 INFO - 'NO_EM_RESTART': '1', 05:26:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:30 INFO - 'PWD': '/builds/slave/test', 05:26:30 INFO - 'SHELL': '/bin/bash', 05:26:30 INFO - 'SHLVL': '1', 05:26:30 INFO - 'TERM': 'linux', 05:26:30 INFO - 'TMOUT': '86400', 05:26:30 INFO - 'USER': 'cltbld', 05:26:30 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1472300097.879568-1396000819', 05:26:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:30 INFO - '_': '/tools/buildbot/bin/python'} 05:26:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:31 INFO - Downloading/unpacking psutil>=3.1.1 05:26:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:26:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:26:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:26:33 INFO - Installing collected packages: psutil 05:26:33 INFO - Running setup.py install for psutil 05:26:33 INFO - building 'psutil._psutil_linux' extension 05:26:33 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 05:26:33 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 05:26:33 INFO - building 'psutil._psutil_posix' extension 05:26:33 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 05:26:33 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 05:26:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:26:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:26:33 INFO - Successfully installed psutil 05:26:33 INFO - Cleaning up... 05:26:33 INFO - Return code: 0 05:26:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:26: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')]} 05:26:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26: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')]} 05:26:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:33 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 0x7f7045738f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199d370>, '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 0x19a08f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a0d80>, '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': '836cfdc75598d54cb747368e000001a9-1472300097.879568-1396000819', '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 05:26:33 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 05:26:33 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 05:26:33 INFO - Using env: {'DISPLAY': ':0', 05:26:33 INFO - 'HOME': '/home/cltbld', 05:26:33 INFO - 'LANG': 'en_US.UTF-8', 05:26:33 INFO - 'LANGUAGE': 'en_US:en', 05:26:33 INFO - 'LOGNAME': 'cltbld', 05:26:33 INFO - 'MAIL': '/var/mail/cltbld', 05:26:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:33 INFO - 'MOZ_NO_REMOTE': '1', 05:26:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:33 INFO - 'NO_EM_RESTART': '1', 05:26:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:33 INFO - 'PWD': '/builds/slave/test', 05:26:33 INFO - 'SHELL': '/bin/bash', 05:26:33 INFO - 'SHLVL': '1', 05:26:33 INFO - 'TERM': 'linux', 05:26:33 INFO - 'TMOUT': '86400', 05:26:33 INFO - 'USER': 'cltbld', 05:26:33 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1472300097.879568-1396000819', 05:26:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:33 INFO - '_': '/tools/buildbot/bin/python'} 05:26:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:26:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:26:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:26:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:26:36 INFO - Installing collected packages: mozsystemmonitor 05:26:36 INFO - Running setup.py install for mozsystemmonitor 05:26:36 INFO - Successfully installed mozsystemmonitor 05:26:36 INFO - Cleaning up... 05:26:36 INFO - Return code: 0 05:26:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:26:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:36 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 0x7f7045738f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199d370>, '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 0x19a08f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a0d80>, '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': '836cfdc75598d54cb747368e000001a9-1472300097.879568-1396000819', '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 05:26:36 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 05:26:36 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 05:26:36 INFO - Using env: {'DISPLAY': ':0', 05:26:36 INFO - 'HOME': '/home/cltbld', 05:26:36 INFO - 'LANG': 'en_US.UTF-8', 05:26:36 INFO - 'LANGUAGE': 'en_US:en', 05:26:36 INFO - 'LOGNAME': 'cltbld', 05:26:36 INFO - 'MAIL': '/var/mail/cltbld', 05:26:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:36 INFO - 'MOZ_NO_REMOTE': '1', 05:26:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:36 INFO - 'NO_EM_RESTART': '1', 05:26:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:36 INFO - 'PWD': '/builds/slave/test', 05:26:36 INFO - 'SHELL': '/bin/bash', 05:26:36 INFO - 'SHLVL': '1', 05:26:36 INFO - 'TERM': 'linux', 05:26:36 INFO - 'TMOUT': '86400', 05:26:36 INFO - 'USER': 'cltbld', 05:26:36 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1472300097.879568-1396000819', 05:26:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:36 INFO - '_': '/tools/buildbot/bin/python'} 05:26:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:36 INFO - Downloading/unpacking jsonschema==2.5.1 05:26:36 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 05:26:36 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 05:26:36 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 05:26:36 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 05:26:36 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 05:26:36 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 05:26:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:26:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:26:38 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 05:26:38 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 05:26:38 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 05:26:38 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 05:26:38 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 05:26:38 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 05:26:38 INFO - Downloading functools32-3.2.3-2.tar.gz 05:26:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:26:38 INFO - warning: no files found matching '*.txt' 05:26:38 INFO - no previously-included directories found matching 'build' 05:26:38 INFO - no previously-included directories found matching 'dist' 05:26:38 INFO - no previously-included directories found matching '.git*' 05:26:38 INFO - Installing collected packages: jsonschema, functools32 05:26:38 INFO - Running setup.py install for functools32 05:26:38 INFO - warning: no files found matching '*.txt' 05:26:38 INFO - no previously-included directories found matching 'build' 05:26:38 INFO - no previously-included directories found matching 'dist' 05:26:38 INFO - no previously-included directories found matching '.git*' 05:26:38 INFO - Successfully installed jsonschema functools32 05:26:38 INFO - Cleaning up... 05:26:38 INFO - Return code: 0 05:26:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:26:38 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')]} 05:26:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:38 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')]} 05:26:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:38 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 0x7f7045738f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199d370>, '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 0x19a08f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a0d80>, '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': '836cfdc75598d54cb747368e000001a9-1472300097.879568-1396000819', '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 05:26:38 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 05:26:38 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 05:26:38 INFO - Using env: {'DISPLAY': ':0', 05:26:38 INFO - 'HOME': '/home/cltbld', 05:26:38 INFO - 'LANG': 'en_US.UTF-8', 05:26:38 INFO - 'LANGUAGE': 'en_US:en', 05:26:38 INFO - 'LOGNAME': 'cltbld', 05:26:38 INFO - 'MAIL': '/var/mail/cltbld', 05:26:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:38 INFO - 'MOZ_NO_REMOTE': '1', 05:26:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:38 INFO - 'NO_EM_RESTART': '1', 05:26:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:38 INFO - 'PWD': '/builds/slave/test', 05:26:38 INFO - 'SHELL': '/bin/bash', 05:26:38 INFO - 'SHLVL': '1', 05:26:38 INFO - 'TERM': 'linux', 05:26:38 INFO - 'TMOUT': '86400', 05:26:38 INFO - 'USER': 'cltbld', 05:26:38 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1472300097.879568-1396000819', 05:26:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:38 INFO - '_': '/tools/buildbot/bin/python'} 05:26:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:26:38 INFO - Cleaning up... 05:26:38 INFO - Return code: 0 05:26:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:26:38 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')]} 05:26:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:38 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')]} 05:26:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:38 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 0x7f7045738f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199d370>, '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 0x19a08f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a0d80>, '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': '836cfdc75598d54cb747368e000001a9-1472300097.879568-1396000819', '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 05:26:38 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 05:26:38 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 05:26:38 INFO - Using env: {'DISPLAY': ':0', 05:26:38 INFO - 'HOME': '/home/cltbld', 05:26:38 INFO - 'LANG': 'en_US.UTF-8', 05:26:38 INFO - 'LANGUAGE': 'en_US:en', 05:26:38 INFO - 'LOGNAME': 'cltbld', 05:26:38 INFO - 'MAIL': '/var/mail/cltbld', 05:26:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:38 INFO - 'MOZ_NO_REMOTE': '1', 05:26:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:38 INFO - 'NO_EM_RESTART': '1', 05:26:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:38 INFO - 'PWD': '/builds/slave/test', 05:26:38 INFO - 'SHELL': '/bin/bash', 05:26:38 INFO - 'SHLVL': '1', 05:26:38 INFO - 'TERM': 'linux', 05:26:38 INFO - 'TMOUT': '86400', 05:26:38 INFO - 'USER': 'cltbld', 05:26:38 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1472300097.879568-1396000819', 05:26:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:38 INFO - '_': '/tools/buildbot/bin/python'} 05:26:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:39 INFO - Downloading/unpacking blobuploader==1.2.4 05:26:39 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 05:26:39 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 05:26:39 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 05:26:39 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 05:26:39 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 05:26:39 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 05:26:41 INFO - Downloading blobuploader-1.2.4.tar.gz 05:26:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:26:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:26:41 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 05:26:41 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 05:26:41 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 05:26:41 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 05:26:41 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 05:26:41 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 05:26:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:26:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:26:41 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 05:26:41 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 05:26:41 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 05:26:41 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 05:26:41 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 05:26:41 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 05:26:41 INFO - Downloading docopt-0.6.1.tar.gz 05:26:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:26:41 INFO - Installing collected packages: blobuploader, requests, docopt 05:26:41 INFO - Running setup.py install for blobuploader 05:26:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:26:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:26:41 INFO - Running setup.py install for requests 05:26:42 INFO - Running setup.py install for docopt 05:26:42 INFO - Successfully installed blobuploader requests docopt 05:26:42 INFO - Cleaning up... 05:26:42 INFO - Return code: 0 05:26:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:26:42 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')]} 05:26:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:42 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')]} 05:26:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:42 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 0x7f7045738f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199d370>, '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 0x19a08f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a0d80>, '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': '836cfdc75598d54cb747368e000001a9-1472300097.879568-1396000819', '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 05:26:42 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 05:26:42 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 05:26:42 INFO - Using env: {'DISPLAY': ':0', 05:26:42 INFO - 'HOME': '/home/cltbld', 05:26:42 INFO - 'LANG': 'en_US.UTF-8', 05:26:42 INFO - 'LANGUAGE': 'en_US:en', 05:26:42 INFO - 'LOGNAME': 'cltbld', 05:26:42 INFO - 'MAIL': '/var/mail/cltbld', 05:26:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:42 INFO - 'MOZ_NO_REMOTE': '1', 05:26:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:42 INFO - 'NO_EM_RESTART': '1', 05:26:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:42 INFO - 'PWD': '/builds/slave/test', 05:26:42 INFO - 'SHELL': '/bin/bash', 05:26:42 INFO - 'SHLVL': '1', 05:26:42 INFO - 'TERM': 'linux', 05:26:42 INFO - 'TMOUT': '86400', 05:26:42 INFO - 'USER': 'cltbld', 05:26:42 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1472300097.879568-1396000819', 05:26:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:42 INFO - '_': '/tools/buildbot/bin/python'} 05:26:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:26:42 INFO - Running setup.py (path:/tmp/pip-AJ0FZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:26:42 INFO - Running setup.py (path:/tmp/pip-CCLoVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:26:42 INFO - Running setup.py (path:/tmp/pip-zx986v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:26:42 INFO - Running setup.py (path:/tmp/pip-RvZ5t1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:26:42 INFO - Running setup.py (path:/tmp/pip-mX1uiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:26:42 INFO - Running setup.py (path:/tmp/pip-5K7YSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:26:43 INFO - Running setup.py (path:/tmp/pip-E2TaLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:26:43 INFO - Running setup.py (path:/tmp/pip-2K8Bns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:26:43 INFO - Running setup.py (path:/tmp/pip-JgMZr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:26:43 INFO - Running setup.py (path:/tmp/pip-F8IiAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:26:43 INFO - Running setup.py (path:/tmp/pip-f1MSQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:26:43 INFO - Running setup.py (path:/tmp/pip-9J_TDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:26:43 INFO - Running setup.py (path:/tmp/pip-hdywEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:26:43 INFO - Running setup.py (path:/tmp/pip-GL2VWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:26:43 INFO - Running setup.py (path:/tmp/pip-1ypfpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:26:43 INFO - Running setup.py (path:/tmp/pip-OsyK0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:26:43 INFO - Running setup.py (path:/tmp/pip-IDbZAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:26:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:26:43 INFO - Running setup.py install for manifestparser 05:26:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:26:43 INFO - Running setup.py install for mozcrash 05:26:44 INFO - Running setup.py install for mozdebug 05:26:44 INFO - Running setup.py install for mozdevice 05:26:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:26:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:26:44 INFO - Running setup.py install for mozfile 05:26:44 INFO - Running setup.py install for mozhttpd 05:26:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:26:44 INFO - Running setup.py install for mozinfo 05:26:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:26:44 INFO - Running setup.py install for mozInstall 05:26:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:26:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:26:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:26:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:26:44 INFO - Running setup.py install for mozleak 05:26:44 INFO - Running setup.py install for mozlog 05:26:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:26:44 INFO - Running setup.py install for moznetwork 05:26:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:26:44 INFO - Running setup.py install for mozprocess 05:26:45 INFO - Running setup.py install for mozprofile 05:26:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:26:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:26:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:26:45 INFO - Running setup.py install for mozrunner 05:26:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:26:45 INFO - Running setup.py install for mozscreenshot 05:26:45 INFO - Running setup.py install for moztest 05:26:45 INFO - Running setup.py install for mozversion 05:26:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:26:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:26:45 INFO - Cleaning up... 05:26:45 INFO - Return code: 0 05:26:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:26: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')]} 05:26:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26: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')]} 05:26:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:45 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 0x7f7045738f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199d370>, '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 0x19a08f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a0d80>, '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': '836cfdc75598d54cb747368e000001a9-1472300097.879568-1396000819', '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 05:26:45 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 05:26:45 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 05:26:45 INFO - Using env: {'DISPLAY': ':0', 05:26:45 INFO - 'HOME': '/home/cltbld', 05:26:45 INFO - 'LANG': 'en_US.UTF-8', 05:26:45 INFO - 'LANGUAGE': 'en_US:en', 05:26:45 INFO - 'LOGNAME': 'cltbld', 05:26:45 INFO - 'MAIL': '/var/mail/cltbld', 05:26:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:45 INFO - 'MOZ_NO_REMOTE': '1', 05:26:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:45 INFO - 'NO_EM_RESTART': '1', 05:26:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:45 INFO - 'PWD': '/builds/slave/test', 05:26:45 INFO - 'SHELL': '/bin/bash', 05:26:45 INFO - 'SHLVL': '1', 05:26:45 INFO - 'TERM': 'linux', 05:26:45 INFO - 'TMOUT': '86400', 05:26:45 INFO - 'USER': 'cltbld', 05:26:45 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1472300097.879568-1396000819', 05:26:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:45 INFO - '_': '/tools/buildbot/bin/python'} 05:26:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:26:45 INFO - Running setup.py (path:/tmp/pip-JfYv7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:26:45 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)) 05:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:26:45 INFO - Running setup.py (path:/tmp/pip-aNUQxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:26:46 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)) 05:26:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:26:46 INFO - Running setup.py (path:/tmp/pip-0EnVwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:26:46 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)) 05:26:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:26:46 INFO - Running setup.py (path:/tmp/pip-CXY87V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:26:46 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)) 05:26:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:26:46 INFO - Running setup.py (path:/tmp/pip-G5F1ji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:26:46 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)) 05:26:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:26:46 INFO - Running setup.py (path:/tmp/pip-Y5cayp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:26:46 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)) 05:26:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:26:46 INFO - Running setup.py (path:/tmp/pip-tnKCsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:26:46 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)) 05:26:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:26:46 INFO - Running setup.py (path:/tmp/pip-ud6nne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:26:46 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)) 05:26:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:26:46 INFO - Running setup.py (path:/tmp/pip-S5qYjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:26:46 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)) 05:26:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:26:46 INFO - Running setup.py (path:/tmp/pip-GOqEsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:26:46 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)) 05:26:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:26:46 INFO - Running setup.py (path:/tmp/pip-Mo4Cbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:26:46 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)) 05:26:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:26:46 INFO - Running setup.py (path:/tmp/pip-Rdmhuy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:26:46 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)) 05:26:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:26:46 INFO - Running setup.py (path:/tmp/pip-wlqOyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:26:46 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)) 05:26:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:26:46 INFO - Running setup.py (path:/tmp/pip-QnYOzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:26:46 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)) 05:26:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:26:46 INFO - Running setup.py (path:/tmp/pip-VCPURb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:26:46 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)) 05:26:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:26:46 INFO - Running setup.py (path:/tmp/pip-rD1CF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:26:47 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)) 05:26:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:26:47 INFO - Running setup.py (path:/tmp/pip-cUKQ5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:26:47 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)) 05:26:47 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)) 05:26:47 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)) 05:26:47 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)) 05:26:47 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)) 05:26:47 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)) 05:26:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:26: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 05:26: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 05:26: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 05:26: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 05:26: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 05:26: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 05:26:48 INFO - Downloading blessings-1.6.tar.gz 05:26:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:26:49 INFO - Installing collected packages: blessings 05:26:49 INFO - Running setup.py install for blessings 05:26:49 INFO - Successfully installed blessings 05:26:49 INFO - Cleaning up... 05:26:49 INFO - Return code: 0 05:26:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:26:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:26:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:26:49 INFO - Reading from file tmpfile_stdout 05:26:49 INFO - Current package versions: 05:26:49 INFO - argparse == 1.2.1 05:26:49 INFO - blessings == 1.6 05:26:49 INFO - blobuploader == 1.2.4 05:26:49 INFO - docopt == 0.6.1 05:26:49 INFO - functools32 == 3.2.3-2 05:26:49 INFO - jsonschema == 2.5.1 05:26:49 INFO - manifestparser == 1.1 05:26:49 INFO - mozInstall == 1.12 05:26:49 INFO - mozcrash == 0.17 05:26:49 INFO - mozdebug == 0.1 05:26:49 INFO - mozdevice == 0.48 05:26:49 INFO - mozfile == 1.2 05:26:49 INFO - mozhttpd == 0.7 05:26:49 INFO - mozinfo == 0.9 05:26:49 INFO - mozleak == 0.1 05:26:49 INFO - mozlog == 3.3 05:26:49 INFO - moznetwork == 0.27 05:26:49 INFO - mozprocess == 0.23 05:26:49 INFO - mozprofile == 0.28 05:26:49 INFO - mozrunner == 6.12 05:26:49 INFO - mozscreenshot == 0.1 05:26:49 INFO - mozsystemmonitor == 0.3 05:26:49 INFO - moztest == 0.7 05:26:49 INFO - mozversion == 1.4 05:26:49 INFO - psutil == 3.1.1 05:26:49 INFO - requests == 1.2.3 05:26:49 INFO - wsgiref == 0.1.2 05:26:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:26:49 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')]} 05:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:49 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')]} 05:26:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:49 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 0x7f7045738f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199d370>, '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 0x19a08f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a0d80>, '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': '836cfdc75598d54cb747368e000001a9-1472300097.879568-1396000819', '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 05:26:49 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 05:26:49 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 05:26:49 INFO - Using env: {'DISPLAY': ':0', 05:26:49 INFO - 'HOME': '/home/cltbld', 05:26:49 INFO - 'LANG': 'en_US.UTF-8', 05:26:49 INFO - 'LANGUAGE': 'en_US:en', 05:26:49 INFO - 'LOGNAME': 'cltbld', 05:26:49 INFO - 'MAIL': '/var/mail/cltbld', 05:26:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:49 INFO - 'MOZ_NO_REMOTE': '1', 05:26:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:49 INFO - 'NO_EM_RESTART': '1', 05:26:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:49 INFO - 'PWD': '/builds/slave/test', 05:26:49 INFO - 'SHELL': '/bin/bash', 05:26:49 INFO - 'SHLVL': '1', 05:26:49 INFO - 'TERM': 'linux', 05:26:49 INFO - 'TMOUT': '86400', 05:26:49 INFO - 'USER': 'cltbld', 05:26:49 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1472300097.879568-1396000819', 05:26:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:49 INFO - '_': '/tools/buildbot/bin/python'} 05:26:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:49 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)) 05:26:49 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)) 05:26:49 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)) 05:26:49 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)) 05:26:49 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)) 05:26:49 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)) 05:26:49 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)) 05:26:49 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)) 05:26:49 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)) 05:26:49 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)) 05:26:49 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)) 05:26:49 INFO - Cleaning up... 05:26:49 INFO - Return code: 0 05:26:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:26:49 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')]} 05:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:49 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')]} 05:26:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:49 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 0x7f7045738f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199d370>, '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 0x19a08f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a0d80>, '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': '836cfdc75598d54cb747368e000001a9-1472300097.879568-1396000819', '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 05:26:49 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 05:26:49 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 05:26:49 INFO - Using env: {'DISPLAY': ':0', 05:26:49 INFO - 'HOME': '/home/cltbld', 05:26:49 INFO - 'LANG': 'en_US.UTF-8', 05:26:49 INFO - 'LANGUAGE': 'en_US:en', 05:26:49 INFO - 'LOGNAME': 'cltbld', 05:26:49 INFO - 'MAIL': '/var/mail/cltbld', 05:26:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:49 INFO - 'MOZ_NO_REMOTE': '1', 05:26:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:49 INFO - 'NO_EM_RESTART': '1', 05:26:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:49 INFO - 'PWD': '/builds/slave/test', 05:26:49 INFO - 'SHELL': '/bin/bash', 05:26:49 INFO - 'SHLVL': '1', 05:26:49 INFO - 'TERM': 'linux', 05:26:49 INFO - 'TMOUT': '86400', 05:26:49 INFO - 'USER': 'cltbld', 05:26:49 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1472300097.879568-1396000819', 05:26:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:49 INFO - '_': '/tools/buildbot/bin/python'} 05:26:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:26:49 INFO - Cleaning up... 05:26:49 INFO - Return code: 0 05:26:49 INFO - Running post-action listener: _resource_record_post_action 05:26:49 INFO - Running post-action listener: _start_resource_monitoring 05:26:49 INFO - Starting resource monitoring. 05:26:49 INFO - [mozharness: 2016-08-27 12:26:49.931717Z] Finished create-virtualenv step (success) 05:26:49 INFO - [mozharness: 2016-08-27 12:26:49.932172Z] Running install step. 05:26:49 INFO - Running pre-action listener: _resource_record_pre_action 05:26:49 INFO - Running main action method: install 05:26:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:26:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:26:50 INFO - Reading from file tmpfile_stdout 05:26:50 INFO - Detecting whether we're running mozinstall >=1.0... 05:26:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:26:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:26:50 INFO - Reading from file tmpfile_stdout 05:26:50 INFO - Output received: 05:26:50 INFO - Usage: mozinstall [options] installer 05:26:50 INFO - Options: 05:26:50 INFO - -h, --help show this help message and exit 05:26:50 INFO - -d DEST, --destination=DEST 05:26:50 INFO - Directory to install application into. [default: 05:26:50 INFO - "/builds/slave/test"] 05:26:50 INFO - --app=APP Application being installed. [default: firefox] 05:26:50 INFO - mkdir: /builds/slave/test/build/application 05:26:50 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'] 05:26:50 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 05:27:07 INFO - Reading from file tmpfile_stdout 05:27:07 INFO - Output received: 05:27:07 INFO - /builds/slave/test/build/application/firefox/firefox 05:27:07 INFO - Running post-action listener: _resource_record_post_action 05:27:07 INFO - [mozharness: 2016-08-27 12:27:07.240829Z] Finished install step (success) 05:27:07 INFO - [mozharness: 2016-08-27 12:27:07.241114Z] Running run-tests step. 05:27:07 INFO - Running pre-action listener: _resource_record_pre_action 05:27:07 INFO - Running main action method: run_tests 05:27:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:27:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:27:07 INFO - Python 2.7.3 05:27:07 INFO - Return code: 0 05:27:07 INFO - grabbing minidump binary from tooltool 05:27:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:07 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 0x199d370>, '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 0x19a08f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a0d80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:27:07 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 05:27:07 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 05:27:07 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 05:27:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:27:07 INFO - Return code: 0 05:27:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:27:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:27:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:27:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:27:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:27:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JdZOMC-nQk-582FFdTeoEw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 05:27:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JdZOMC-nQk-582FFdTeoEw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --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 05:27:07 INFO - Using env: {'DISPLAY': ':0', 05:27:07 INFO - 'HOME': '/home/cltbld', 05:27:07 INFO - 'LANG': 'en_US.UTF-8', 05:27:07 INFO - 'LANGUAGE': 'en_US:en', 05:27:07 INFO - 'LOGNAME': 'cltbld', 05:27:07 INFO - 'MAIL': '/var/mail/cltbld', 05:27:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:27:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:27:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:07 INFO - 'MOZ_NO_REMOTE': '1', 05:27:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:27:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:07 INFO - 'NO_EM_RESTART': '1', 05:27:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:07 INFO - 'PWD': '/builds/slave/test', 05:27:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:27:07 INFO - 'SHELL': '/bin/bash', 05:27:07 INFO - 'SHLVL': '1', 05:27:07 INFO - 'TERM': 'linux', 05:27:07 INFO - 'TMOUT': '86400', 05:27:07 INFO - 'USER': 'cltbld', 05:27:07 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1472300097.879568-1396000819', 05:27:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:07 INFO - '_': '/tools/buildbot/bin/python'} 05:27:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JdZOMC-nQk-582FFdTeoEw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 05:27:07 INFO - mozversion application_buildid: 20160827023002 05:27:07 INFO - mozversion application_changeset: 087a40f5eaa909ceea0d41f0357c50ee3df47a4d 05:27:07 INFO - mozversion application_display_name: Nightly 05:27:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:27:07 INFO - mozversion application_name: Firefox 05:27:07 INFO - mozversion application_remotingname: firefox 05:27:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:27:07 INFO - mozversion application_vendor: Mozilla 05:27:07 INFO - mozversion application_version: 51.0a1 05:27:07 INFO - mozversion platform_buildid: 20160827023002 05:27:07 INFO - mozversion platform_changeset: 087a40f5eaa909ceea0d41f0357c50ee3df47a4d 05:27:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:27:07 INFO - mozversion platform_version: 51.0a1 05:27:07 INFO - using testdate: 1472300827 05:27:07 INFO - actual date: 1472300827 05:27:07 INFO - starting webserver on 'localhost:55377' 05:27:07 INFO - SUITE-START | Running 2 tests 05:27:07 INFO - TEST-START | dromaeo_css 05:27:07 INFO - operating with platform_type : linux_ 05:27:07 INFO - Initialising browser for dromaeo_css test... 05:27:07 INFO - TEST-INFO | started process 4339 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBwkwho/profile http://localhost:55377/getInfo.html) 05:27:11 INFO - PROCESS | 4339 | __metrics Screen width/height:1600/1200 05:27:11 INFO - PROCESS | 4339 | colorDepth:24 05:27:11 INFO - PROCESS | 4339 | Browser inner width/height: 1024/697 05:27:11 INFO - PROCESS | 4339 | __metrics 05:27:12 INFO - PROCESS | 4339 | 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" 05:27:12 INFO - PROCESS | 4339 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:27:13 INFO - PROCESS | 4339 | console.error: PushService: 05:27:13 INFO - PROCESS | 4339 | stateChangeProcessEnqueue: Error transitioning state 05:27:13 INFO - PROCESS | 4339 | UnknownError 05:27:13 INFO - TEST-INFO | 4339: exit 0 05:27:13 INFO - Browser initialized. 05:27:13 INFO - Running cycle 1/1 for dromaeo_css test... 05:27:13 INFO - TEST-INFO | started process 4422 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBwkwho/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:27:25 INFO - PROCESS | 4422 | RSS: Main: 178917376 05:27:25 INFO - PROCESS | 4422 | 05:28:17 INFO - PROCESS | 4422 | 1472300897508 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] 05:30:26 INFO - PROCESS | 4422 | Cycle 1(1): loaded http://localhost:55377/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55377/tests/dromaeo/cssquery-ext.html) 05:30:27 INFO - PROCESS | 4422 | RSS: Main: 298074112 05:30:27 INFO - PROCESS | 4422 | 05:33:30 INFO - PROCESS | 4422 | Cycle 1(1): loaded http://localhost:55377/tests/dromaeo/cssquery-ext.html (next: http://localhost:55377/tests/dromaeo/cssquery-jquery.html) 05:33:30 INFO - PROCESS | 4422 | RSS: Main: 271273984 05:33:30 INFO - PROCESS | 4422 | 05:36:32 INFO - PROCESS | 4422 | Cycle 1(1): loaded http://localhost:55377/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55377/tests/dromaeo/cssquery-mootools.html) 05:36:33 INFO - PROCESS | 4422 | RSS: Main: 215060480 05:36:33 INFO - PROCESS | 4422 | 05:39:35 INFO - PROCESS | 4422 | Cycle 1(1): loaded http://localhost:55377/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55377/tests/dromaeo/cssquery-prototype.html) 05:39:36 INFO - PROCESS | 4422 | RSS: Main: 240316416 05:39:36 INFO - PROCESS | 4422 | 05:42:38 INFO - PROCESS | 4422 | Cycle 1(1): loaded http://localhost:55377/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55377/tests/dromaeo/cssquery-yui.html) 05:42:39 INFO - PROCESS | 4422 | RSS: Main: 215764992 05:42:39 INFO - PROCESS | 4422 | 05:45:42 INFO - PROCESS | 4422 | Cycle 1(1): loaded http://localhost:55377/tests/dromaeo/cssquery-yui.html (next: http://localhost:55377/tests/dromaeo/cssquery-dojo.html) 05:45:42 INFO - PROCESS | 4422 | RSS: Main: 307691520 05:45:42 INFO - PROCESS | 4422 | 05:45:42 INFO - PROCESS | 4422 | __start_tp_report 05:45:42 INFO - PROCESS | 4422 | _x_x_mozilla_page_load 05:45:42 INFO - PROCESS | 4422 | _x_x_mozilla_page_load_details 05:45:42 INFO - PROCESS | 4422 | |i|pagename|runs| 05:45:42 INFO - PROCESS | 4422 | |0;dojo.html;2996.3408050228954;3027.8031927924685;3033.2416895776055;3075.2004478835497;3085.6451508076566;5107.412647545533;5180.948190518094;5199.19412491064;5226.555742761865;5255.421903590607;5208.609354298424;5212.556932660728;5273.973630131844;5278.392984806758;5320.521153096221;4669.556392142741;4729.077829823186;4740.454847692507;4748.738819364934;4894.3147959285725;4803.255495398202;4835.05716385305;4844.781984810692;4857.441394239655;4879.975600122012;4660.39414876064;4700.694454860423;4729.9763501182615;4753.619710423158;4785.928211076836;4691.530846915315;4694.108119457293;4698.154332220199;4750.596199323062;4804.159272127364;4686.507916668769;4716.3632909557455;4724.220503616899;4731.69243999139;4780.665353425262;5121.769520371555;5190.195519694454;5196.662216955886;5228.451012643655;5247.816326428557;5562.833115006556;5602.459323685978;5615.101583746622;5622.381538030813;5623.887522249532;5621.550275977912;5631.380548139701;5638.154276858463;5639.774409023634;5652.236948012007;5085.23721441783;5171.456997015297;5210.791568337224;5214.165733482625;5292.126799078186;5694.4590263924865;5695.857603559944;5696.8860622787315;5699.601027928005;5706.3722990471015;5466.453354664502;5475.67145971243;5476.069068258405;5477.452254774491;5478.58910581708;5456.781728730806;5525.475079867406;5552.639078459887;5556.222128901957;5629.324481062217;5548.55611551075;5555.416681248411;5558.333000040021;5561.6663000220115;5561.6663000220115;5513.558915286768;5557.72211389437;5565.777368905279;5577.163425486209;5638.295213098363;4224.429701990192;4261.382099595541;4285.892852678646;4313.352997050468;4324.632406245504;3850.9602407350417;3859.054531639766;3865.381538953754;3903.316919539069;3904.1996390739832;5273.920891186635;5282.313299271147;5324.068288049576;5328.49379308965;5345;5471.699056551848;5562.165675148679;5591.524720398812;5612.915806262909;5626.099824028218;5328.174133009312;5332.040232758063;5343.278657381204;5384.811531596375;5391.487808658171;4847.054824309296;4867.902641947141;4888.437829649564;4893.681910675866;4950.628702847229;5641.971790141023;5709.34342550612;5719.656820590694;5786.276715410574;5793.7392817323325;5616.073347897551;5620.156976453564;5623.662580245198;5675.858103547444;5689.431056894277;5769.68266745333;5770.192173095854;5774.56690748204;5781.248437703071;5788.421157884178;5336.439673834191;5435.347758269033;5443.455654434525;5516.80691175823;5518.944810551843;5540.612157149122;5577.358603760457;5593.552515798645;5637.492625663546;5658;5403.324584426947;5461.890762184655;5474.91787623194;5478.150886612581;5478.534324582296;5371.811986580451;5401.918971215357;5416.566674666096;5449.209864569536;5511.090670039559;5451.672899626035;5453.918191227214;5460.2355670207;5507.614466987273;5519.365272993497;5465;5488.91766623493;5489.231507588861;5498.285222920995;5500.119980803052;5251.264822924717;5298.3906850712665;5299.046171688979;5383.515483606494;5448.83653490396 05:45:42 INFO - PROCESS | 4422 | |1;ext.html;547.0952907187067;596.3112604941293;608.9360617135198;617.3610313325709;623.5821999260495;41278.380824287626;42543;42684.57315426849;42712.572874271245;47431.525684743145;45343.77328113363;45384.773076134654;45413;45758.542414575844;45770;9034.72895813125;9165.954170229139;9191.264698824112;9203.125703058233;9286.953565232197;8981.685641002567;9062.909370906273;9078.364514483988;9078.636854525812;9081.863772043425;9138.725838224864;9139.771505712377;9168.449893006407;9175.311851611123;9178.72463826083;9091.36360454765;9098.317626177997;9126.315526335518;9129.680461183892;9133.862992055125;8846.911530884738;8884.289256859436;8934.15125563077;8935.68725094625;8942.061083586259;42304.365434518506;42642;42709.09881671901;42743.57256427427;42917.14165716699;3485.9477107843404;3669.7064234861145;3747.1756213632957;3911.3350730375905;4143.81352839123;31606;32424.513632295533;32599;32668.509972350435;32719.836400818083;4349.391085248068;4512.616427603658;4518.2319005769095;4522.072975040109;4578.931316030262;344569.27715361514;345180;347122;347267;347629;58056.41943580595;58558.55855855852;58644;58687;58777.70611146917;62490.375096249365;62986.37013629897;63277.36722632807;63280.36719632745;63372.366276336645;17039;17294.13529323529;17313;17320.913395433196;17327.56681082958;13225.404856781468;13295.069345145746;13350.332483375792;13359.666008349675;13366.39851206698;13169.407376668072;17294.394696185573;17417;17534.123293835513;17667.823321766875;5201.503278426377;6171.84570385744;6204.875902481925;6236;6323.146375239284;1001.6293971230691;1023.1098943918689;1077.2728408324506;1126.5099681638515;1156.9305841649527;31968.840155799073;32950.340993180005;32987.835060824546;33062;33702.15744606405;1104.7679987202616;1144.8494263265532;1170.5902933973211;1171.7832201042834;1188.061431469147;16915.323387064378;17317;17323.22045507955;17344.653106938043;17450.563735906704;567542;570135;570741;575160;575345;56486.43513564894;56541.43458565444;56575.71712141413;56691.433085668614;56702;1217.3365515793914;1314.2705798282045;1345.7712188927906;1353.4450875141144;1357.9728405431836;31565.368692625558;32441.83779081184;33766;33877.322453550296;34207.18984915485;50616;51291.48708512867;51326.74336628293;51335.22997154971;51374.22938655998;418480;419077;419383;420985;420989;27885;28800.711992879802;28893.855530722212;29655.258618533848;29881;47521.762391187825;47672.2849157256;48438;48597.757011216134;49373.50626493689;40149.598504015754;40252.597474024886;40454.1909161821;41804.790976044926;43018.35472467853;40541.39187912125;40660;40845.183096337314;41809.58190418179;42015;40961;41350.79324603358;41578.376324354555;42226.788866055475;42283.36574951317;34895;37240;37252.60539969338;37560.43659345167;38233.80883095567;28109;28168.85915570409;28478.57282140728;28492.145235642965;28527.28681782972 05:45:42 INFO - PROCESS | 4422 | |2;jquery.html;386.2815163795342;402.1574800792339;407.43977031581574;411.5596311946218;426.17535069640246;15363.462278820229;19058.42824715259;19101.42695719127;19255.133518991643;19331.613367732636;12132.818007729891;12373.752524949496;12522.186057906252;12534.310612916286;12627.116101872873;5227.320448341719;5426.647267927572;5430.15832545956;5432.348118225798;5434.212039254306;5178.378594568657;5328.893422131555;5364.436734142898;5377.381601115863;5377.973110134463;5348.438413966536;5355.705436201008;5357.49103835137;5365.409804921455;5368.436314187013;5333.893322133555;5342.839714808562;5654.745536450849;5887.676177810219;5926.525877929756;5773.769049238025;5785.074388097884;5785.768569257225;5785.942140578582;5786.68173250471;13277.933610331984;13525.661858453519;14143.85856141446;14452.205128717917;14575.344109515097;2416.1664225842055;2431.878406079689;2562.7565381288746;2741.5065288248106;2893.8408387538675;10192.184625230038;10251;10503.894961050368;10527.631532896388;10623.946880265548;1828.6525560143664;1886.2549293029176;1917.5781328107794;1924.3264857299973;1927.2194761121768;78071;80301;80650.5967470159;83097.58451207705;84048;8881;9343.112404321579;9450;10989.560417583207;11433;12297.938510307571;12331.630051098482;12379.381030948416;12380.257184568954;12902;7883.329916957008;8034.638441270157;8064.435489515678;8238;8257.504549727035;7983.481073730189;8055.718049868344;8251.504909705436;8256.463329883658;8320.292775114061;4112.424260603518;4183.707140500136;4212.578742125763;4304.18220538103;4323.113761678848;1902.3056584346614;1975.7036444533435;1986.7019947007775;2034.043999320317;2050.4361300642445;876.8947726272888;951.2770294576034;953.4327075390132;996.8056229035268;1010.3937637417638;18283.26866925308;18840.528986775167;19451.416457506297;19471.805281947283;19863.900680496507;942.2509105261197;974.4202199691173;985.5072463768116;987.7530617345664;990.2919412619867;10064.597416103274;10677.83983240252;10816.567337306577;10864.402457864893;10950.780984380268;474201;482335;484343;490754;494196;59960.70019649961;86169;88440.5577972106;90752.09247907568;92213.07786922179;965.8502932045544;977;995.9452230127267;997.3068717241448;997.9002099789963;16116.516504504883;16857.831421686118;17340.225563909713;17512.64974700524;17526.649467010844;40543.79728101341;40559.39160912648;41009.384859227735;41370.37944430776;41416.171676566904;53328.73335633297;56058.1591276123;56103;56324.43675563356;56374.718126409105;8553.74338769838;8706.56467176626;8820.632801915714;8828.823423531365;8979.281657467518;10714.303570267908;12413.255204687748;12599.811002834782;12879;13087.345632718136;10800.729981750519;11585.304881707125;11716.648500544998;11810.232334898204;12150.331731754484;11365.374904380338;11526.711832204262;11718.121140914294;11841.763164736829;12190.08574356909;11510.769784604428;11731.23746956445;11842.703932401759;12085.456154473246;12297.56958506448;7661.846763064819;8583.527905964982;8630.482171069756;8752.562371881508;9103.49930753815;9862.901370986197;11140.944295278472;11313.377764223047;11512.53949841997;11901.940490297493 05:45:42 INFO - PROCESS | 4422 | |3;mootools.html;1295.145204165251;1419.3683810704238;1468.2218424235157;1574.5040312301624;1756.0780590190147;7872.76381708549;8207.876881846769;8210.137935516774;8359.623816928237;8430.662773489054;8252.876206856887;8255.133211012848;8316.334693224542;8368.790780230498;8370.162983701643;2031.8374530037636;2302.3323236261463;2342.402687314741;2366.9763302367014;2370.0519792083132;2341.730700969385;2357.811375089989;2363.373705967911;2363.4327761337327;2367.1714899785024;2310.786836910627;2312.109837712476;2315.6873822034063;2354.058376649337;2359.374765687094;2213.1147540983575;2277.760835112306;2280.247518318951;2288.096202000209;2291.1179196009575;2300.608896487601;2312.8496647717843;2330.906763729449;2330.9161240023473;2338.286822519131;8602.569871506399;8603.225709686158;8685.305175585938;8686.522241276727;8688.956555217184;4962.652614316963;5097.5667068299235;5097.974510127463;5106.974465127688;5109.233614957786;3147.4334619768433;3304.1739565108724;3364.4785058316;3369.1469691669486;3372.37611041958;1062.2617280989716;1110.783397237539;1119.13826353708;1120.383788916093;1125.2685754259714;11553.884461155449;11630.418479076012;11658.883411165865;11679.065674746;11682.299062056303;4177.916441671149;4293.656507479394;4463.263561512379;4503;4508.256137737237;9211.953940230256;9213.447193168431;9219.216366608913;9263.351565390492;9280.118388753057;4892.657513974059;4947.703137811671;4956.479569645207;4986.700797952134;4988.401391833003;4000.819963101609;4502.8198872045405;4608.101420223024;4608.9308660370125;4652.069586082729;3678.889633311005;3760.9623903761158;3819.5416550014174;3868;3882.2623701496627;1145.2956431794387;1161.814109742454;1168.7195073182374;1178.2282604893808;1186.1874615888144;840.5923127283263;871.5685735560811;949.4398305000083;957.8323793336277;984.2372161574693;5574.9721251393485;5619.4099619540175;5630.718464076862;5852.941470585325;5854.560907931922;452.9909401811945;455.6673628251395;467.53246753246754;476.1429427031399;483.84033269021137;3845.442410850467;3918.8236529355677;3954.406838974177;3981.22366138606;3989.162275922031;10214.897851021395;10530.473476326153;10628.36229826213;10642.521086550969;10654.893451065545;10548.683539493828;10552;10552.997465240944;10597.788044239227;10605.734856628646;7831.295183433518;7938.04743430792;7960.601969901481;7964.323032542183;7983.640736166771;5733.197352370755;5770.480656740913;5859.414058594277;5921.970390148022;6171.1360409543595;9341.159295663423;9576.377535460173;9607.423554586747;9638.807223855623;9640.746702928855;9979.850302245326;9992.15066719337;9995.400275983464;9995.600175992879;10003.599856005969;6449.290578036506;7065.82335441618;7242.275772422716;7345.522541034816;7470.775876723707;8310.875336870073;8476.364272679697;8478.872816907628;8481.745547633582;8483.872741908754;7159.069320988238;7504.2120577340775;7644.732434364771;7684.423668224794;7824;7273.199948005609;7413.629318533944;7413.851722965618;7435.776926692208;7663.846723065619;6415.230172379344;6520.054592084216;6530.8040758777315;6533.248676402274;6533.803985880431;4907;4978.7510624467905;5043.9747801260755;5083.87290317745;5137.486251374833;4874.829380971649;4971;5013.824516141917;5024.422191447884;5153.613478989166 05:45:42 INFO - PROCESS | 4422 | |4;prototype.html;331.023480731841;345.9066052165915;346.64122633074766;349.2491144040313;349.59097855509054;5087.677203926978;5182.2226666000115;5298.682079075254;5311.654742441739;5315.867103322419;5175.327207463025;5189.534970888826;5219.9478005219935;5225.817096401626;5250.501202385777;4165.27107756143;4168.124693814302;4173.520045194811;4174.415581818548;4177.582241775828;4056.2822908651274;4151.83392664293;4153.314703073989;4167.187398457302;4170.165966806636;4075.9796201019103;4087.2438598859158;4103.733257338278;4104.199681062194;4130.566290539495;4082.306007978636;4086.346184610448;4092.5498195198506;4106.425100485934;4113.136241389312;3676.7977761223124;3682.2819550187724;3683.650053244937;3708.8887333380044;3723.9627603724157;4909.754512274408;5025.221090730943;5056.772445239936;5059.229269755593;5075.822346217865;4661.114388266253;4672.5327467253;4672.906541869178;4687.507811679793;4699.506551812079;5406.783728650849;5407.242985981966;5416.997855396764;5418.647787893774;5439.782408703647;3764.5482542095124;3971.1660551284267;3981.8009099545197;3985.3822657488136;4008.2985477541315;5624.521915637176;5649.576281778883;5651.547876169897;5655.462731040545;5663.546916246691;4045.9190816183514;4078.7552746835286;4079.796010199478;4083.714140010171;4084.7957602119777;3935.252302062599;4126.576331165743;4129.15352352767;4130.380442933524;4144.647704945053;4647.489565891099;4652.720836749806;4653;4654.697444666086;4669.39297891272;5398.865028374244;5401.405845357008;5459.372172200247;5474;5474.562035037187;1344.764666183414;1350.3180893648644;1402.3759427055068;1416.992915035439;1427.079533700757;965.6137544981923;971.1842052675786;990.9108180263811;992.4987881120132;993.3295025857517;5246.108161612535;5250;5257.290265814143;5259.158534634516;5263.157894736823;5487.204355368449;5500.614956953055;5505.449455054542;5507.944920550824;5547.528460080857;5052.191649336089;5225.817096401608;5242.633015688865;5257.78968841242;5309.628326017219;2934.6478422589425;2958.778091643135;2965.3476235228213;2973.334932437842;2973.435047340998;5775.393583673737;5794.449527294901;5811.389804070596;5816.970915145397;5823.650580965155;5596.244506991504;5641.915371269434;5689.630174038674;5699.772009119672;5713.628614140068;5745;5749.798757043483;5749.9712501437225;5751.913721294184;5757.8560535986935;5361.544268737201;5559.8308963890195;5566.805161819317;5602.607817452739;5630;5515.7242137893745;5540.390557038803;5546.58400619947;5549.361823390362;5579.330480342385;5781.768729250783;5787.768489260382;5797.304323481209;5803.506701930383;5805.82582522525;3924.803759811941;4040.1717647881524;4051.2377115954655;4063.89840253996;4065.8780236592947;5282.841514754564;5544;5549.833504994856;5551.528120109836;5581.944180558305;5247.737613119405;5393.27190829233;5409.5672346213;5440.183972404171;5453.454654534515;5413.242146099628;5434.2392065110125;5435.374931882884;5439.884823611229;5457.672539647634;5182.97408512955;5368.8389348319615;5377.435369286169;5381.4169198785585;5430.565554755689;5433.5109840113;5458.5087342139395;5459.918101228405;5460.2355670207;5465.754041068082;5229.869253268699;5317.8404647860625;5339.519443250126;5349.251104845247;5364.865878353073 05:45:42 INFO - PROCESS | 4422 | |5;yui.html;754.9056367954006;797.1828875402713;800.7002397127427;810.6676262732279;817.8936738224033;14746.926265368686;15874.761878571831;16539.503814885542;16540.421085262034;16551.255193516292;15770;15784.526464206063;15874.761878571831;15890.126043067627;15909.52271431856;663.3466035954581;805.2350267246125;824.9752507424787;825.038829763325;825.0553116681397;794.0352471746827;800.9359251259885;811.8011087283594;834.4951304460805;835.3943391041477;843.472829481574;843.9956451822312;844.8901642786429;845.0071166379511;845.8815765792793;681.9386255237052;847.3179090831878;847.4788005376711;848.6732607945954;850.370725663008;608.6135304081896;613.4846728747829;618.6226401894841;629.7166275176144;629.8393909553081;14439.855601443956;14540.418383264763;14558.781618275734;14567;14574.927125364411;14043.929780351134;14349.641258968504;14686;14704.77585933785;15092.16993065381;13131.212127272394;13136.86863131366;13245.668858278525;13536.05247632666;13591.592252232449;4408.493023302329;4463.174312752151;4482.260427029569;4494.348319493655;4546.704464209849;80971;81697.59151204205;82302.58848705718;83678.21378755204;88620.11379886183;11417.37204453763;11459.369734664508;11490.54037838477;11513.136514761427;11794.705132371759;21701.891490542446;21777.78222217789;21792.564148716938;21794.455138621342;21824.89087554552;8344.123866994;8459.830803383898;8747.693830715894;8819.338549608805;8832.381733278737;4789.114013907439;4879.658423910292;4905;4936.456989731127;5045.772940217626;3248.447763880146;3321.335732853439;3322.186064414234;3355.9496607550905;3358.126887009395;580.2080160580861;586.9002269614176;591.9408059194046;594.1236675903009;604.1753007145215;637.8022812928007;654.6693919570587;686.7802303262907;701.7649087555624;702.1048163591462;9650.227981761442;9676.467794271382;9690.70927872165;9736.855146439395;9927.950360248153;630.4074170279922;638.4541217259269;695.1775790291433;700.7827573452246;702.118840854724;4301.913961720748;4338.652907767371;4627.329037289574;4729.196036673774;4733.763311834395;79798.60100699459;94335;136876;137569;141662;111982.44008779904;113893;114458;114467;120348.77907325588;93270.53364733269;99950;100321.49839250756;100878.49560752149;101247;8131.837363252584;8715.738527844174;8959.596818143069;8980.955095224483;9116.316276279173;50670.493295066575;53695.46304537061;54307.728461359024;54997.725011374685;55698.72150639383;80769;81762.32069557003;82206.17793821986;84182;85031.14968850232;10976.341419514854;11356.545738170711;11423.600173993871;11563.88436115628;11678;12674.176178548365;12688.6827829305;12990.805137922749;13236.470541178245;13561.389737462036;12258.20321679088;12724.809127863275;12759.48962041508;12895.613131606067;13093.934530327288;12255;12523.373831308216;12621.684457888627;13089.476420943056;13212.603621891358;11800.17398782077;12080.577179798665;12598.05514586428;12609.30648814324;12618.873811262138;10224.28430009922;10401.739956501147;10749.355038697704;10750.892491075301;11076.833847492133;8437.873431898404;9539.570719317786;10089.697309080739;10236.897631023594;10323.94838025805 05:45:42 INFO - PROCESS | 4422 | __end_tp_report 05:45:42 INFO - PROCESS | 4422 | __start_cc_report 05:45:42 INFO - PROCESS | 4422 | _x_x_mozilla_cycle_collect,1034 05:45:42 INFO - PROCESS | 4422 | __end_cc_report 05:45:42 INFO - PROCESS | 4422 | __startTimestamp1472301942838__endTimestamp 05:45:42 INFO - PROCESS | 4422 | 05:45:42 INFO - PROCESS | 4422 | ------- Summary: start ------- 05:45:42 INFO - PROCESS | 4422 | Number of tests: 6 05:45:42 INFO - PROCESS | 4422 | 05:45:42 INFO - PROCESS | 4422 | [#0] dojo.html Cycles:165 Average:5195.19 Median:5403.32 stddev:578.19 (10.7%) stddev-sans-first:553.64 05:45:42 INFO - PROCESS | 4422 | Values: 2996.3 3027.8 3033.2 3075.2 3085.6 5107.4 5180.9 5199.2 5226.6 5255.4 5208.6 5212.6 5274.0 5278.4 5320.5 4669.6 4729.1 4740.5 4748.7 4894.3 4803.3 4835.1 4844.8 4857.4 4880.0 4660.4 4700.7 4730.0 4753.6 4785.9 4691.5 4694.1 4698.2 4750.6 4804.2 4686.5 4716.4 4724.2 4731.7 4780.7 5121.8 5190.2 5196.7 5228.5 5247.8 5562.8 5602.5 5615.1 5622.4 5623.9 5621.6 5631.4 5638.2 5639.8 5652.2 5085.2 5171.5 5210.8 5214.2 5292.1 5694.5 5695.9 5696.9 5699.6 5706.4 5466.5 5475.7 5476.1 5477.5 5478.6 5456.8 5525.5 5552.6 5556.2 5629.3 5548.6 5555.4 5558.3 5561.7 5561.7 5513.6 5557.7 5565.8 5577.2 5638.3 4224.4 4261.4 4285.9 4313.4 4324.6 3851.0 3859.1 3865.4 3903.3 3904.2 5273.9 5282.3 5324.1 5328.5 5345.0 5471.7 5562.2 5591.5 5612.9 5626.1 5328.2 5332.0 5343.3 5384.8 5391.5 4847.1 4867.9 4888.4 4893.7 4950.6 5642.0 5709.3 5719.7 5786.3 5793.7 5616.1 5620.2 5623.7 5675.9 5689.4 5769.7 5770.2 5774.6 5781.2 5788.4 5336.4 5435.3 5443.5 5516.8 5518.9 5540.6 5577.4 5593.6 5637.5 5658.0 5403.3 5461.9 5474.9 5478.2 5478.5 5371.8 5401.9 5416.6 5449.2 5511.1 5451.7 5453.9 5460.2 5507.6 5519.4 5465.0 5488.9 5489.2 5498.3 5500.1 5251.3 5298.4 5299.0 5383.5 5448.8 05:45:42 INFO - PROCESS | 4422 | 05:45:42 INFO - PROCESS | 4422 | [#1] ext.html Cycles:180 Average:60901.25 Median:231500.00 stddev:120968.01 (52.3%) stddev-sans-first:121222.49 05:45:42 INFO - PROCESS | 4422 | Values: 547.1 596.3 608.9 617.4 623.6 41278.4 42543.0 42684.6 42712.6 47431.5 45343.8 45384.8 45413.0 45758.5 45770.0 9034.7 9166.0 9191.3 9203.1 9287.0 8981.7 9062.9 9078.4 9078.6 9081.9 9138.7 9139.8 9168.4 9175.3 9178.7 9091.4 9098.3 9126.3 9129.7 9133.9 8846.9 8884.3 8934.2 8935.7 8942.1 42304.4 42642.0 42709.1 42743.6 42917.1 3485.9 3669.7 3747.2 3911.3 4143.8 31606.0 32424.5 32599.0 32668.5 32719.8 4349.4 4512.6 4518.2 4522.1 4578.9 344569.3 345180.0 347122.0 347267.0 347629.0 58056.4 58558.6 58644.0 58687.0 58777.7 62490.4 62986.4 63277.4 63280.4 63372.4 17039.0 17294.1 17313.0 17320.9 17327.6 13225.4 13295.1 13350.3 13359.7 13366.4 13169.4 17294.4 17417.0 17534.1 17667.8 5201.5 6171.8 6204.9 6236.0 6323.1 1001.6 1023.1 1077.3 1126.5 1156.9 31968.8 32950.3 32987.8 33062.0 33702.2 1104.8 1144.8 1170.6 1171.8 1188.1 16915.3 17317.0 17323.2 17344.7 17450.6 567542.0 570135.0 570741.0 575160.0 575345.0 56486.4 56541.4 56575.7 56691.4 56702.0 1217.3 1314.3 1345.8 1353.4 1358.0 31565.4 32441.8 33766.0 33877.3 34207.2 50616.0 51291.5 51326.7 51335.2 51374.2 418480.0 419077.0 419383.0 420985.0 420989.0 27885.0 28800.7 28893.9 29655.3 29881.0 47521.8 47672.3 48438.0 48597.8 49373.5 40149.6 40252.6 40454.2 41804.8 43018.4 40541.4 40660.0 40845.2 41809.6 42015.0 40961.0 41350.8 41578.4 42226.8 42283.4 34895.0 37240.0 37252.6 37560.4 38233.8 28109.0 28168.9 28478.6 28492.1 28527.3 05:45:42 INFO - PROCESS | 4422 | 05:45:42 INFO - PROCESS | 4422 | [#2] jquery.html Cycles:180 Average:27918.19 Median:41393.28 stddev:79955.30 (193.2%) stddev-sans-first:80152.87 05:45:42 INFO - PROCESS | 4422 | Values: 386.3 402.2 407.4 411.6 426.2 15363.5 19058.4 19101.4 19255.1 19331.6 12132.8 12373.8 12522.2 12534.3 12627.1 5227.3 5426.6 5430.2 5432.3 5434.2 5178.4 5328.9 5364.4 5377.4 5378.0 5348.4 5355.7 5357.5 5365.4 5368.4 5333.9 5342.8 5654.7 5887.7 5926.5 5773.8 5785.1 5785.8 5785.9 5786.7 13277.9 13525.7 14143.9 14452.2 14575.3 2416.2 2431.9 2562.8 2741.5 2893.8 10192.2 10251.0 10503.9 10527.6 10623.9 1828.7 1886.3 1917.6 1924.3 1927.2 78071.0 80301.0 80650.6 83097.6 84048.0 8881.0 9343.1 9450.0 10989.6 11433.0 12297.9 12331.6 12379.4 12380.3 12902.0 7883.3 8034.6 8064.4 8238.0 8257.5 7983.5 8055.7 8251.5 8256.5 8320.3 4112.4 4183.7 4212.6 4304.2 4323.1 1902.3 1975.7 1986.7 2034.0 2050.4 876.9 951.3 953.4 996.8 1010.4 18283.3 18840.5 19451.4 19471.8 19863.9 942.3 974.4 985.5 987.8 990.3 10064.6 10677.8 10816.6 10864.4 10950.8 474201.0 482335.0 484343.0 490754.0 494196.0 59960.7 86169.0 88440.6 90752.1 92213.1 965.9 977.0 995.9 997.3 997.9 16116.5 16857.8 17340.2 17512.6 17526.6 40543.8 40559.4 41009.4 41370.4 41416.2 53328.7 56058.2 56103.0 56324.4 56374.7 8553.7 8706.6 8820.6 8828.8 8979.3 10714.3 12413.3 12599.8 12879.0 13087.3 10800.7 11585.3 11716.6 11810.2 12150.3 11365.4 11526.7 11718.1 11841.8 12190.1 11510.8 11731.2 11842.7 12085.5 12297.6 7661.8 8583.5 8630.5 8752.6 9103.5 9862.9 11140.9 11313.4 11512.5 11901.9 05:45:42 INFO - PROCESS | 4422 | 05:45:42 INFO - PROCESS | 4422 | [#3] mootools.html Cycles:180 Average:5556.61 Median:4959.57 stddev:3153.19 (63.6%) stddev-sans-first:3145.77 05:45:42 INFO - PROCESS | 4422 | Values: 1295.1 1419.4 1468.2 1574.5 1756.1 7872.8 8207.9 8210.1 8359.6 8430.7 8252.9 8255.1 8316.3 8368.8 8370.2 2031.8 2302.3 2342.4 2367.0 2370.1 2341.7 2357.8 2363.4 2363.4 2367.2 2310.8 2312.1 2315.7 2354.1 2359.4 2213.1 2277.8 2280.2 2288.1 2291.1 2300.6 2312.8 2330.9 2330.9 2338.3 8602.6 8603.2 8685.3 8686.5 8689.0 4962.7 5097.6 5098.0 5107.0 5109.2 3147.4 3304.2 3364.5 3369.1 3372.4 1062.3 1110.8 1119.1 1120.4 1125.3 11553.9 11630.4 11658.9 11679.1 11682.3 4177.9 4293.7 4463.3 4503.0 4508.3 9212.0 9213.4 9219.2 9263.4 9280.1 4892.7 4947.7 4956.5 4986.7 4988.4 4000.8 4502.8 4608.1 4608.9 4652.1 3678.9 3761.0 3819.5 3868.0 3882.3 1145.3 1161.8 1168.7 1178.2 1186.2 840.6 871.6 949.4 957.8 984.2 5575.0 5619.4 5630.7 5852.9 5854.6 453.0 455.7 467.5 476.1 483.8 3845.4 3918.8 3954.4 3981.2 3989.2 10214.9 10530.5 10628.4 10642.5 10654.9 10548.7 10552.0 10553.0 10597.8 10605.7 7831.3 7938.0 7960.6 7964.3 7983.6 5733.2 5770.5 5859.4 5922.0 6171.1 9341.2 9576.4 9607.4 9638.8 9640.7 9979.9 9992.2 9995.4 9995.6 10003.6 6449.3 7065.8 7242.3 7345.5 7470.8 8310.9 8476.4 8478.9 8481.7 8483.9 7159.1 7504.2 7644.7 7684.4 7824.0 7273.2 7413.6 7413.9 7435.8 7663.8 6415.2 6520.1 6530.8 6533.2 6533.8 4907.0 4978.8 5044.0 5083.9 5137.5 4874.8 4971.0 5013.8 5024.4 5153.6 05:45:42 INFO - PROCESS | 4422 | 05:45:42 INFO - PROCESS | 4422 | [#4] prototype.html Cycles:180 Average:4607.81 Median:5257.54 stddev:1331.31 (25.3%) stddev-sans-first:1295.77 05:45:42 INFO - PROCESS | 4422 | Values: 331.0 345.9 346.6 349.2 349.6 5087.7 5182.2 5298.7 5311.7 5315.9 5175.3 5189.5 5219.9 5225.8 5250.5 4165.3 4168.1 4173.5 4174.4 4177.6 4056.3 4151.8 4153.3 4167.2 4170.2 4076.0 4087.2 4103.7 4104.2 4130.6 4082.3 4086.3 4092.5 4106.4 4113.1 3676.8 3682.3 3683.7 3708.9 3724.0 4909.8 5025.2 5056.8 5059.2 5075.8 4661.1 4672.5 4672.9 4687.5 4699.5 5406.8 5407.2 5417.0 5418.6 5439.8 3764.5 3971.2 3981.8 3985.4 4008.3 5624.5 5649.6 5651.5 5655.5 5663.5 4045.9 4078.8 4079.8 4083.7 4084.8 3935.3 4126.6 4129.2 4130.4 4144.6 4647.5 4652.7 4653.0 4654.7 4669.4 5398.9 5401.4 5459.4 5474.0 5474.6 1344.8 1350.3 1402.4 1417.0 1427.1 965.6 971.2 990.9 992.5 993.3 5246.1 5250.0 5257.3 5259.2 5263.2 5487.2 5500.6 5505.4 5507.9 5547.5 5052.2 5225.8 5242.6 5257.8 5309.6 2934.6 2958.8 2965.3 2973.3 2973.4 5775.4 5794.4 5811.4 5817.0 5823.7 5596.2 5641.9 5689.6 5699.8 5713.6 5745.0 5749.8 5750.0 5751.9 5757.9 5361.5 5559.8 5566.8 5602.6 5630.0 5515.7 5540.4 5546.6 5549.4 5579.3 5781.8 5787.8 5797.3 5803.5 5805.8 3924.8 4040.2 4051.2 4063.9 4065.9 5282.8 5544.0 5549.8 5551.5 5581.9 5247.7 5393.3 5409.6 5440.2 5453.5 5413.2 5434.2 5435.4 5439.9 5457.7 5183.0 5368.8 5377.4 5381.4 5430.6 5433.5 5458.5 5459.9 5460.2 5465.8 5229.9 5317.8 5339.5 5349.3 5364.9 05:45:42 INFO - PROCESS | 4422 | 05:45:42 INFO - PROCESS | 4422 | [#5] yui.html Cycles:180 Average:22045.57 Median:4587.02 stddev:33403.08 (728.2%) stddev-sans-first:33458.53 05:45:42 INFO - PROCESS | 4422 | Values: 754.9 797.2 800.7 810.7 817.9 14746.9 15874.8 16539.5 16540.4 16551.3 15770.0 15784.5 15874.8 15890.1 15909.5 663.3 805.2 825.0 825.0 825.1 794.0 800.9 811.8 834.5 835.4 843.5 844.0 844.9 845.0 845.9 681.9 847.3 847.5 848.7 850.4 608.6 613.5 618.6 629.7 629.8 14439.9 14540.4 14558.8 14567.0 14574.9 14043.9 14349.6 14686.0 14704.8 15092.2 13131.2 13136.9 13245.7 13536.1 13591.6 4408.5 4463.2 4482.3 4494.3 4546.7 80971.0 81697.6 82302.6 83678.2 88620.1 11417.4 11459.4 11490.5 11513.1 11794.7 21701.9 21777.8 21792.6 21794.5 21824.9 8344.1 8459.8 8747.7 8819.3 8832.4 4789.1 4879.7 4905.0 4936.5 5045.8 3248.4 3321.3 3322.2 3355.9 3358.1 580.2 586.9 591.9 594.1 604.2 637.8 654.7 686.8 701.8 702.1 9650.2 9676.5 9690.7 9736.9 9928.0 630.4 638.5 695.2 700.8 702.1 4301.9 4338.7 4627.3 4729.2 4733.8 79798.6 94335.0 136876.0 137569.0 141662.0 111982.4 113893.0 114458.0 114467.0 120348.8 93270.5 99950.0 100321.5 100878.5 101247.0 8131.8 8715.7 8959.6 8981.0 9116.3 50670.5 53695.5 54307.7 54997.7 55698.7 80769.0 81762.3 82206.2 84182.0 85031.1 10976.3 11356.5 11423.6 11563.9 11678.0 12674.2 12688.7 12990.8 13236.5 13561.4 12258.2 12724.8 12759.5 12895.6 13093.9 12255.0 12523.4 12621.7 13089.5 13212.6 11800.2 12080.6 12598.1 12609.3 12618.9 10224.3 10401.7 10749.4 10750.9 11076.8 8437.9 9539.6 10089.7 10236.9 10323.9 05:45:42 INFO - PROCESS | 4422 | -------- Summary: end -------- 05:45:42 INFO - PROCESS | 4422 | 05:45:43 INFO - TEST-INFO | 4422: exit 0 05:45:43 INFO - TEST-OK | dromaeo_css | took 1116275ms 05:45:43 INFO - TEST-START | kraken 05:45:43 INFO - operating with platform_type : linux_ 05:45:43 INFO - Initialising browser for kraken test... 05:45:43 INFO - TEST-INFO | started process 4729 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRJXLtj/profile http://localhost:55377/getInfo.html) 05:45:48 INFO - PROCESS | 4729 | __metrics Screen width/height:1600/1200 05:45:48 INFO - PROCESS | 4729 | colorDepth:24 05:45:48 INFO - PROCESS | 4729 | Browser inner width/height: 1024/697 05:45:48 INFO - PROCESS | 4729 | __metrics 05:45:48 INFO - PROCESS | 4729 | 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" 05:45:48 INFO - PROCESS | 4729 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:45:49 INFO - PROCESS | 4729 | console.error: PushService: 05:45:49 INFO - PROCESS | 4729 | stateChangeProcessEnqueue: Error transitioning state 05:45:49 INFO - PROCESS | 4729 | UnknownError 05:45:50 INFO - TEST-INFO | 4729: exit 0 05:45:50 INFO - Browser initialized. 05:45:50 INFO - Running cycle 1/1 for kraken test... 05:45:50 INFO - TEST-INFO | started process 4811 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRJXLtj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:46:02 INFO - PROCESS | 4811 | RSS: Main: 179011584 05:46:02 INFO - PROCESS | 4811 | 05:46:04 INFO - PROCESS | 4811 | Cycle 1(1): loaded http://localhost:55377/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55377/tests/kraken/driver.html?testName=audio-beat-detection) 05:46:05 INFO - PROCESS | 4811 | RSS: Main: 241868800 05:46:05 INFO - PROCESS | 4811 | 05:46:08 INFO - PROCESS | 4811 | Cycle 1(1): loaded http://localhost:55377/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55377/tests/kraken/driver.html?testName=audio-dft) 05:46:08 INFO - PROCESS | 4811 | RSS: Main: 223416320 05:46:08 INFO - PROCESS | 4811 | 05:46:11 INFO - PROCESS | 4811 | Cycle 1(1): loaded http://localhost:55377/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55377/tests/kraken/driver.html?testName=audio-fft) 05:46:12 INFO - PROCESS | 4811 | RSS: Main: 300965888 05:46:12 INFO - PROCESS | 4811 | 05:46:14 INFO - PROCESS | 4811 | Cycle 1(1): loaded http://localhost:55377/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55377/tests/kraken/driver.html?testName=audio-oscillator) 05:46:15 INFO - PROCESS | 4811 | RSS: Main: 211959808 05:46:15 INFO - PROCESS | 4811 | 05:46:17 INFO - PROCESS | 4811 | Cycle 1(1): loaded http://localhost:55377/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55377/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:46:17 INFO - PROCESS | 4811 | RSS: Main: 213487616 05:46:17 INFO - PROCESS | 4811 | 05:46:20 INFO - PROCESS | 4811 | Cycle 1(1): loaded http://localhost:55377/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55377/tests/kraken/driver.html?testName=imaging-darkroom) 05:46:21 INFO - PROCESS | 4811 | RSS: Main: 252272640 05:46:21 INFO - PROCESS | 4811 | 05:46:24 INFO - PROCESS | 4811 | Cycle 1(1): loaded http://localhost:55377/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55377/tests/kraken/driver.html?testName=imaging-desaturate) 05:46:25 INFO - PROCESS | 4811 | RSS: Main: 251527168 05:46:25 INFO - PROCESS | 4811 | 05:46:28 INFO - PROCESS | 4811 | Cycle 1(1): loaded http://localhost:55377/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55377/tests/kraken/driver.html?testName=json-parse-financial) 05:46:28 INFO - PROCESS | 4811 | RSS: Main: 251314176 05:46:28 INFO - PROCESS | 4811 | 05:46:30 INFO - PROCESS | 4811 | Cycle 1(1): loaded http://localhost:55377/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55377/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:46:30 INFO - PROCESS | 4811 | RSS: Main: 213618688 05:46:30 INFO - PROCESS | 4811 | 05:46:32 INFO - PROCESS | 4811 | Cycle 1(1): loaded http://localhost:55377/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55377/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:46:33 INFO - PROCESS | 4811 | RSS: Main: 220557312 05:46:33 INFO - PROCESS | 4811 | 05:46:35 INFO - PROCESS | 4811 | Cycle 1(1): loaded http://localhost:55377/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55377/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:46:36 INFO - PROCESS | 4811 | RSS: Main: 222228480 05:46:36 INFO - PROCESS | 4811 | 05:46:38 INFO - PROCESS | 4811 | Cycle 1(1): loaded http://localhost:55377/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55377/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:46:39 INFO - PROCESS | 4811 | RSS: Main: 223182848 05:46:39 INFO - PROCESS | 4811 | 05:46:42 INFO - PROCESS | 4811 | Cycle 1(1): loaded http://localhost:55377/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55377/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:46:42 INFO - PROCESS | 4811 | RSS: Main: 221085696 05:46:42 INFO - PROCESS | 4811 | 05:46:44 INFO - PROCESS | 4811 | Cycle 1(1): loaded http://localhost:55377/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55377/tests/kraken/driver.html?testName=ai-astar) 05:46:44 INFO - PROCESS | 4811 | RSS: Main: 272318464 05:46:44 INFO - PROCESS | 4811 | 05:46:44 INFO - PROCESS | 4811 | __start_tp_report 05:46:44 INFO - PROCESS | 4811 | _x_x_mozilla_page_load 05:46:44 INFO - PROCESS | 4811 | _x_x_mozilla_page_load_details 05:46:44 INFO - PROCESS | 4811 | |i|pagename|runs| 05:46:44 INFO - PROCESS | 4811 | |0;ai-astar;113;113;130;110;111;111;111;111;112;114 05:46:44 INFO - PROCESS | 4811 | |1;audio-beat-detection;151;125;144;185;118;149;152;126;176;123 05:46:44 INFO - PROCESS | 4811 | |2;audio-dft;160;162;161;160;161;162;162;164;160;162 05:46:44 INFO - PROCESS | 4811 | |3;audio-fft;76;76;76;179;77;75;75;76;174;76 05:46:44 INFO - PROCESS | 4811 | |4;audio-oscillator;83;83;145;83;83;83;144;83;81;141 05:46:44 INFO - PROCESS | 4811 | |5;imaging-gaussian-blur;118;118;117;117;116;117;116;117;117;116 05:46:44 INFO - PROCESS | 4811 | |6;imaging-darkroom;147;147;145;148;150;146;146;145;146;146 05:46:44 INFO - PROCESS | 4811 | |7;imaging-desaturate;94;95;95;96;95;95;95;95;96;95 05:46:44 INFO - PROCESS | 4811 | |8;json-parse-financial;51;50;53;53;52;53;52;52;52;52 05:46:44 INFO - PROCESS | 4811 | |9;json-stringify-tinderbox;62;61;61;61;61;62;61;63;62;63 05:46:44 INFO - PROCESS | 4811 | |10;stanford-crypto-aes;84;79;84;78;79;78;77;83;77;78 05:46:44 INFO - PROCESS | 4811 | |11;stanford-crypto-ccm;134;122;125;132;132;126;134;126;168;129 05:46:44 INFO - PROCESS | 4811 | |12;stanford-crypto-pbkdf2;164;165;162;163;166;161;163;162;161;162 05:46:44 INFO - PROCESS | 4811 | |13;stanford-crypto-sha256-iterative;65;65;65;64;64;64;67;64;63;63 05:46:44 INFO - PROCESS | 4811 | __end_tp_report 05:46:44 INFO - PROCESS | 4811 | __start_cc_report 05:46:44 INFO - PROCESS | 4811 | _x_x_mozilla_cycle_collect,1719 05:46:44 INFO - PROCESS | 4811 | __end_cc_report 05:46:44 INFO - PROCESS | 4811 | __startTimestamp1472302004518__endTimestamp 05:46:44 INFO - PROCESS | 4811 | 05:46:44 INFO - PROCESS | 4811 | ------- Summary: start ------- 05:46:44 INFO - PROCESS | 4811 | Number of tests: 14 05:46:44 INFO - PROCESS | 4811 | 05:46:44 INFO - PROCESS | 4811 | [#0] ai-astar Cycles:10 Average:113.60 Median:112.50 stddev:5.89 (5.2%) stddev-sans-first:6.24 05:46:44 INFO - PROCESS | 4811 | Values: 113.0 113.0 130.0 110.0 111.0 111.0 111.0 111.0 112.0 114.0 05:46:44 INFO - PROCESS | 4811 | 05:46:44 INFO - PROCESS | 4811 | [#1] audio-beat-detection Cycles:10 Average:144.90 Median:150.00 stddev:22.70 (15.1%) stddev-sans-first:23.97 05:46:44 INFO - PROCESS | 4811 | Values: 151.0 125.0 144.0 185.0 118.0 149.0 152.0 126.0 176.0 123.0 05:46:44 INFO - PROCESS | 4811 | 05:46:44 INFO - PROCESS | 4811 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:1.26 (0.8%) stddev-sans-first:1.24 05:46:44 INFO - PROCESS | 4811 | Values: 160.0 162.0 161.0 160.0 161.0 162.0 162.0 164.0 160.0 162.0 05:46:44 INFO - PROCESS | 4811 | 05:46:44 INFO - PROCESS | 4811 | [#3] audio-fft Cycles:10 Average:96.00 Median:76.00 stddev:42.45 (55.9%) stddev-sans-first:44.40 05:46:44 INFO - PROCESS | 4811 | Values: 76.0 76.0 76.0 179.0 77.0 75.0 75.0 76.0 174.0 76.0 05:46:44 INFO - PROCESS | 4811 | 05:46:44 INFO - PROCESS | 4811 | [#4] audio-oscillator Cycles:10 Average:100.90 Median:83.00 stddev:29.30 (35.3%) stddev-sans-first:30.36 05:46:44 INFO - PROCESS | 4811 | Values: 83.0 83.0 145.0 83.0 83.0 83.0 144.0 83.0 81.0 141.0 05:46:44 INFO - PROCESS | 4811 | 05:46:44 INFO - PROCESS | 4811 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.67 05:46:44 INFO - PROCESS | 4811 | Values: 118.0 118.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 116.0 05:46:44 INFO - PROCESS | 4811 | 05:46:44 INFO - PROCESS | 4811 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:146.50 stddev:1.51 (1.0%) stddev-sans-first:1.59 05:46:44 INFO - PROCESS | 4811 | Values: 147.0 147.0 145.0 148.0 150.0 146.0 146.0 145.0 146.0 146.0 05:46:44 INFO - PROCESS | 4811 | 05:46:44 INFO - PROCESS | 4811 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.44 05:46:44 INFO - PROCESS | 4811 | Values: 94.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 95.0 05:46:44 INFO - PROCESS | 4811 | 05:46:44 INFO - PROCESS | 4811 | [#8] json-parse-financial Cycles:10 Average:52.00 Median:52.00 stddev:0.94 (1.8%) stddev-sans-first:0.93 05:46:44 INFO - PROCESS | 4811 | Values: 51.0 50.0 53.0 53.0 52.0 53.0 52.0 52.0 52.0 52.0 05:46:44 INFO - PROCESS | 4811 | 05:46:44 INFO - PROCESS | 4811 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:62.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 05:46:44 INFO - PROCESS | 4811 | Values: 62.0 61.0 61.0 61.0 61.0 62.0 61.0 63.0 62.0 63.0 05:46:44 INFO - PROCESS | 4811 | 05:46:44 INFO - PROCESS | 4811 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:79.00 stddev:2.83 (3.6%) stddev-sans-first:2.54 05:46:44 INFO - PROCESS | 4811 | Values: 84.0 79.0 84.0 78.0 79.0 78.0 77.0 83.0 77.0 78.0 05:46:44 INFO - PROCESS | 4811 | 05:46:44 INFO - PROCESS | 4811 | [#11] stanford-crypto-ccm Cycles:10 Average:132.80 Median:132.00 stddev:13.03 (9.9%) stddev-sans-first:13.81 05:46:44 INFO - PROCESS | 4811 | Values: 134.0 122.0 125.0 132.0 132.0 126.0 134.0 126.0 168.0 129.0 05:46:44 INFO - PROCESS | 4811 | 05:46:44 INFO - PROCESS | 4811 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.90 Median:163.00 stddev:1.66 (1.0%) stddev-sans-first:1.72 05:46:44 INFO - PROCESS | 4811 | Values: 164.0 165.0 162.0 163.0 166.0 161.0 163.0 162.0 161.0 162.0 05:46:44 INFO - PROCESS | 4811 | 05:46:44 INFO - PROCESS | 4811 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:64.50 stddev:1.17 (1.8%) stddev-sans-first:1.22 05:46:44 INFO - PROCESS | 4811 | Values: 65.0 65.0 65.0 64.0 64.0 64.0 67.0 64.0 63.0 63.0 05:46:44 INFO - PROCESS | 4811 | -------- Summary: end -------- 05:46:44 INFO - PROCESS | 4811 | 05:46:45 INFO - TEST-INFO | 4811: exit 0 05:46:45 INFO - TEST-OK | kraken | took 61980ms 05:46:45 INFO - SUITE-END | took 1178s 05:46:46 INFO - Completed test suite (00:19:38) 05:46:46 INFO - javascript benchmark 05:46:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2996.3408050228954, 3027.8031927924685, 3033.2416895776055, 3075.2004478835497, 3085.6451508076566, 5107.412647545533, 5180.948190518094, 5199.19412491064, 5226.555742761865, 5255.421903590607, 5208.609354298424, 5212.556932660728, 5273.973630131844, 5278.392984806758, 5320.521153096221, 4669.556392142741, 4729.077829823186, 4740.454847692507, 4748.738819364934, 4894.3147959285725, 4803.255495398202, 4835.05716385305, 4844.781984810692, 4857.441394239655, 4879.975600122012, 4660.39414876064, 4700.694454860423, 4729.9763501182615, 4753.619710423158, 4785.928211076836, 4691.530846915315, 4694.108119457293, 4698.154332220199, 4750.596199323062, 4804.159272127364, 4686.507916668769, 4716.3632909557455, 4724.220503616899, 4731.69243999139, 4780.665353425262, 5121.769520371555, 5190.195519694454, 5196.662216955886, 5228.451012643655, 5247.816326428557, 5562.833115006556, 5602.459323685978, 5615.101583746622, 5622.381538030813, 5623.887522249532, 5621.550275977912, 5631.380548139701, 5638.154276858463, 5639.774409023634, 5652.236948012007, 5085.23721441783, 5171.456997015297, 5210.791568337224, 5214.165733482625, 5292.126799078186, 5694.4590263924865, 5695.857603559944, 5696.8860622787315, 5699.601027928005, 5706.3722990471015, 5466.453354664502, 5475.67145971243, 5476.069068258405, 5477.452254774491, 5478.58910581708, 5456.781728730806, 5525.475079867406, 5552.639078459887, 5556.222128901957, 5629.324481062217, 5548.55611551075, 5555.416681248411, 5558.333000040021, 5561.6663000220115, 5561.6663000220115, 5513.558915286768, 5557.72211389437, 5565.777368905279, 5577.163425486209, 5638.295213098363, 4224.429701990192, 4261.382099595541, 4285.892852678646, 4313.352997050468, 4324.632406245504, 3850.9602407350417, 3859.054531639766, 3865.381538953754, 3903.316919539069, 3904.1996390739832, 5273.920891186635, 5282.313299271147, 5324.068288049576, 5328.49379308965, 5345.0, 5471.699056551848, 5562.165675148679, 5591.524720398812, 5612.915806262909, 5626.099824028218, 5328.174133009312, 5332.040232758063, 5343.278657381204, 5384.811531596375, 5391.487808658171, 4847.054824309296, 4867.902641947141, 4888.437829649564, 4893.681910675866, 4950.628702847229, 5641.971790141023, 5709.34342550612, 5719.656820590694, 5786.276715410574, 5793.7392817323325, 5616.073347897551, 5620.156976453564, 5623.662580245198, 5675.858103547444, 5689.431056894277, 5769.68266745333, 5770.192173095854, 5774.56690748204, 5781.248437703071, 5788.421157884178, 5336.439673834191, 5435.347758269033, 5443.455654434525, 5516.80691175823, 5518.944810551843, 5540.612157149122, 5577.358603760457, 5593.552515798645, 5637.492625663546, 5658.0, 5403.324584426947, 5461.890762184655, 5474.91787623194, 5478.150886612581, 5478.534324582296, 5371.811986580451, 5401.918971215357, 5416.566674666096, 5449.209864569536, 5511.090670039559, 5451.672899626035, 5453.918191227214, 5460.2355670207, 5507.614466987273, 5519.365272993497, 5465.0, 5488.91766623493, 5489.231507588861, 5498.285222920995, 5500.119980803052, 5251.264822924717, 5298.3906850712665, 5299.046171688979, 5383.515483606494, 5448.83653490396], "value": 5156.864236426335, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.0952907187067, 596.3112604941293, 608.9360617135198, 617.3610313325709, 623.5821999260495, 41278.380824287626, 42543.0, 42684.57315426849, 42712.572874271245, 47431.525684743145, 45343.77328113363, 45384.773076134654, 45413.0, 45758.542414575844, 45770.0, 9034.72895813125, 9165.954170229139, 9191.264698824112, 9203.125703058233, 9286.953565232197, 8981.685641002567, 9062.909370906273, 9078.364514483988, 9078.636854525812, 9081.863772043425, 9138.725838224864, 9139.771505712377, 9168.449893006407, 9175.311851611123, 9178.72463826083, 9091.36360454765, 9098.317626177997, 9126.315526335518, 9129.680461183892, 9133.862992055125, 8846.911530884738, 8884.289256859436, 8934.15125563077, 8935.68725094625, 8942.061083586259, 42304.365434518506, 42642.0, 42709.09881671901, 42743.57256427427, 42917.14165716699, 3485.9477107843404, 3669.7064234861145, 3747.1756213632957, 3911.3350730375905, 4143.81352839123, 31606.0, 32424.513632295533, 32599.0, 32668.509972350435, 32719.836400818083, 4349.391085248068, 4512.616427603658, 4518.2319005769095, 4522.072975040109, 4578.931316030262, 344569.27715361514, 345180.0, 347122.0, 347267.0, 347629.0, 58056.41943580595, 58558.55855855852, 58644.0, 58687.0, 58777.70611146917, 62490.375096249365, 62986.37013629897, 63277.36722632807, 63280.36719632745, 63372.366276336645, 17039.0, 17294.13529323529, 17313.0, 17320.913395433196, 17327.56681082958, 13225.404856781468, 13295.069345145746, 13350.332483375792, 13359.666008349675, 13366.39851206698, 13169.407376668072, 17294.394696185573, 17417.0, 17534.123293835513, 17667.823321766875, 5201.503278426377, 6171.84570385744, 6204.875902481925, 6236.0, 6323.146375239284, 1001.6293971230691, 1023.1098943918689, 1077.2728408324506, 1126.5099681638515, 1156.9305841649527, 31968.840155799073, 32950.340993180005, 32987.835060824546, 33062.0, 33702.15744606405, 1104.7679987202616, 1144.8494263265532, 1170.5902933973211, 1171.7832201042834, 1188.061431469147, 16915.323387064378, 17317.0, 17323.22045507955, 17344.653106938043, 17450.563735906704, 567542.0, 570135.0, 570741.0, 575160.0, 575345.0, 56486.43513564894, 56541.43458565444, 56575.71712141413, 56691.433085668614, 56702.0, 1217.3365515793914, 1314.2705798282045, 1345.7712188927906, 1353.4450875141144, 1357.9728405431836, 31565.368692625558, 32441.83779081184, 33766.0, 33877.322453550296, 34207.18984915485, 50616.0, 51291.48708512867, 51326.74336628293, 51335.22997154971, 51374.22938655998, 418480.0, 419077.0, 419383.0, 420985.0, 420989.0, 27885.0, 28800.711992879802, 28893.855530722212, 29655.258618533848, 29881.0, 47521.762391187825, 47672.2849157256, 48438.0, 48597.757011216134, 49373.50626493689, 40149.598504015754, 40252.597474024886, 40454.1909161821, 41804.790976044926, 43018.35472467853, 40541.39187912125, 40660.0, 40845.183096337314, 41809.58190418179, 42015.0, 40961.0, 41350.79324603358, 41578.376324354555, 42226.788866055475, 42283.36574951317, 34895.0, 37240.0, 37252.60539969338, 37560.43659345167, 38233.80883095567, 28109.0, 28168.85915570409, 28478.57282140728, 28492.145235642965, 28527.28681782972], "value": 20282.867192147645, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.2815163795342, 402.1574800792339, 407.43977031581574, 411.5596311946218, 426.17535069640246, 15363.462278820229, 19058.42824715259, 19101.42695719127, 19255.133518991643, 19331.613367732636, 12132.818007729891, 12373.752524949496, 12522.186057906252, 12534.310612916286, 12627.116101872873, 5227.320448341719, 5426.647267927572, 5430.15832545956, 5432.348118225798, 5434.212039254306, 5178.378594568657, 5328.893422131555, 5364.436734142898, 5377.381601115863, 5377.973110134463, 5348.438413966536, 5355.705436201008, 5357.49103835137, 5365.409804921455, 5368.436314187013, 5333.893322133555, 5342.839714808562, 5654.745536450849, 5887.676177810219, 5926.525877929756, 5773.769049238025, 5785.074388097884, 5785.768569257225, 5785.942140578582, 5786.68173250471, 13277.933610331984, 13525.661858453519, 14143.85856141446, 14452.205128717917, 14575.344109515097, 2416.1664225842055, 2431.878406079689, 2562.7565381288746, 2741.5065288248106, 2893.8408387538675, 10192.184625230038, 10251.0, 10503.894961050368, 10527.631532896388, 10623.946880265548, 1828.6525560143664, 1886.2549293029176, 1917.5781328107794, 1924.3264857299973, 1927.2194761121768, 78071.0, 80301.0, 80650.5967470159, 83097.58451207705, 84048.0, 8881.0, 9343.112404321579, 9450.0, 10989.560417583207, 11433.0, 12297.938510307571, 12331.630051098482, 12379.381030948416, 12380.257184568954, 12902.0, 7883.329916957008, 8034.638441270157, 8064.435489515678, 8238.0, 8257.504549727035, 7983.481073730189, 8055.718049868344, 8251.504909705436, 8256.463329883658, 8320.292775114061, 4112.424260603518, 4183.707140500136, 4212.578742125763, 4304.18220538103, 4323.113761678848, 1902.3056584346614, 1975.7036444533435, 1986.7019947007775, 2034.043999320317, 2050.4361300642445, 876.8947726272888, 951.2770294576034, 953.4327075390132, 996.8056229035268, 1010.3937637417638, 18283.26866925308, 18840.528986775167, 19451.416457506297, 19471.805281947283, 19863.900680496507, 942.2509105261197, 974.4202199691173, 985.5072463768116, 987.7530617345664, 990.2919412619867, 10064.597416103274, 10677.83983240252, 10816.567337306577, 10864.402457864893, 10950.780984380268, 474201.0, 482335.0, 484343.0, 490754.0, 494196.0, 59960.70019649961, 86169.0, 88440.5577972106, 90752.09247907568, 92213.07786922179, 965.8502932045544, 977.0, 995.9452230127267, 997.3068717241448, 997.9002099789963, 16116.516504504883, 16857.831421686118, 17340.225563909713, 17512.64974700524, 17526.649467010844, 40543.79728101341, 40559.39160912648, 41009.384859227735, 41370.37944430776, 41416.171676566904, 53328.73335633297, 56058.1591276123, 56103.0, 56324.43675563356, 56374.718126409105, 8553.74338769838, 8706.56467176626, 8820.632801915714, 8828.823423531365, 8979.281657467518, 10714.303570267908, 12413.255204687748, 12599.811002834782, 12879.0, 13087.345632718136, 10800.729981750519, 11585.304881707125, 11716.648500544998, 11810.232334898204, 12150.331731754484, 11365.374904380338, 11526.711832204262, 11718.121140914294, 11841.763164736829, 12190.08574356909, 11510.769784604428, 11731.23746956445, 11842.703932401759, 12085.456154473246, 12297.56958506448, 7661.846763064819, 8583.527905964982, 8630.482171069756, 8752.562371881508, 9103.49930753815, 9862.901370986197, 11140.944295278472, 11313.377764223047, 11512.53949841997, 11901.940490297493], "value": 8787.142512067123, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1295.145204165251, 1419.3683810704238, 1468.2218424235157, 1574.5040312301624, 1756.0780590190147, 7872.76381708549, 8207.876881846769, 8210.137935516774, 8359.623816928237, 8430.662773489054, 8252.876206856887, 8255.133211012848, 8316.334693224542, 8368.790780230498, 8370.162983701643, 2031.8374530037636, 2302.3323236261463, 2342.402687314741, 2366.9763302367014, 2370.0519792083132, 2341.730700969385, 2357.811375089989, 2363.373705967911, 2363.4327761337327, 2367.1714899785024, 2310.786836910627, 2312.109837712476, 2315.6873822034063, 2354.058376649337, 2359.374765687094, 2213.1147540983575, 2277.760835112306, 2280.247518318951, 2288.096202000209, 2291.1179196009575, 2300.608896487601, 2312.8496647717843, 2330.906763729449, 2330.9161240023473, 2338.286822519131, 8602.569871506399, 8603.225709686158, 8685.305175585938, 8686.522241276727, 8688.956555217184, 4962.652614316963, 5097.5667068299235, 5097.974510127463, 5106.974465127688, 5109.233614957786, 3147.4334619768433, 3304.1739565108724, 3364.4785058316, 3369.1469691669486, 3372.37611041958, 1062.2617280989716, 1110.783397237539, 1119.13826353708, 1120.383788916093, 1125.2685754259714, 11553.884461155449, 11630.418479076012, 11658.883411165865, 11679.065674746, 11682.299062056303, 4177.916441671149, 4293.656507479394, 4463.263561512379, 4503.0, 4508.256137737237, 9211.953940230256, 9213.447193168431, 9219.216366608913, 9263.351565390492, 9280.118388753057, 4892.657513974059, 4947.703137811671, 4956.479569645207, 4986.700797952134, 4988.401391833003, 4000.819963101609, 4502.8198872045405, 4608.101420223024, 4608.9308660370125, 4652.069586082729, 3678.889633311005, 3760.9623903761158, 3819.5416550014174, 3868.0, 3882.2623701496627, 1145.2956431794387, 1161.814109742454, 1168.7195073182374, 1178.2282604893808, 1186.1874615888144, 840.5923127283263, 871.5685735560811, 949.4398305000083, 957.8323793336277, 984.2372161574693, 5574.9721251393485, 5619.4099619540175, 5630.718464076862, 5852.941470585325, 5854.560907931922, 452.9909401811945, 455.6673628251395, 467.53246753246754, 476.1429427031399, 483.84033269021137, 3845.442410850467, 3918.8236529355677, 3954.406838974177, 3981.22366138606, 3989.162275922031, 10214.897851021395, 10530.473476326153, 10628.36229826213, 10642.521086550969, 10654.893451065545, 10548.683539493828, 10552.0, 10552.997465240944, 10597.788044239227, 10605.734856628646, 7831.295183433518, 7938.04743430792, 7960.601969901481, 7964.323032542183, 7983.640736166771, 5733.197352370755, 5770.480656740913, 5859.414058594277, 5921.970390148022, 6171.1360409543595, 9341.159295663423, 9576.377535460173, 9607.423554586747, 9638.807223855623, 9640.746702928855, 9979.850302245326, 9992.15066719337, 9995.400275983464, 9995.600175992879, 10003.599856005969, 6449.290578036506, 7065.82335441618, 7242.275772422716, 7345.522541034816, 7470.775876723707, 8310.875336870073, 8476.364272679697, 8478.872816907628, 8481.745547633582, 8483.872741908754, 7159.069320988238, 7504.2120577340775, 7644.732434364771, 7684.423668224794, 7824.0, 7273.199948005609, 7413.629318533944, 7413.851722965618, 7435.776926692208, 7663.846723065619, 6415.230172379344, 6520.054592084216, 6530.8040758777315, 6533.248676402274, 6533.803985880431, 4907.0, 4978.7510624467905, 5043.9747801260755, 5083.87290317745, 5137.486251374833, 4874.829380971649, 4971.0, 5013.824516141917, 5024.422191447884, 5153.613478989166], "value": 4391.301726183295, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.023480731841, 345.9066052165915, 346.64122633074766, 349.2491144040313, 349.59097855509054, 5087.677203926978, 5182.2226666000115, 5298.682079075254, 5311.654742441739, 5315.867103322419, 5175.327207463025, 5189.534970888826, 5219.9478005219935, 5225.817096401626, 5250.501202385777, 4165.27107756143, 4168.124693814302, 4173.520045194811, 4174.415581818548, 4177.582241775828, 4056.2822908651274, 4151.83392664293, 4153.314703073989, 4167.187398457302, 4170.165966806636, 4075.9796201019103, 4087.2438598859158, 4103.733257338278, 4104.199681062194, 4130.566290539495, 4082.306007978636, 4086.346184610448, 4092.5498195198506, 4106.425100485934, 4113.136241389312, 3676.7977761223124, 3682.2819550187724, 3683.650053244937, 3708.8887333380044, 3723.9627603724157, 4909.754512274408, 5025.221090730943, 5056.772445239936, 5059.229269755593, 5075.822346217865, 4661.114388266253, 4672.5327467253, 4672.906541869178, 4687.507811679793, 4699.506551812079, 5406.783728650849, 5407.242985981966, 5416.997855396764, 5418.647787893774, 5439.782408703647, 3764.5482542095124, 3971.1660551284267, 3981.8009099545197, 3985.3822657488136, 4008.2985477541315, 5624.521915637176, 5649.576281778883, 5651.547876169897, 5655.462731040545, 5663.546916246691, 4045.9190816183514, 4078.7552746835286, 4079.796010199478, 4083.714140010171, 4084.7957602119777, 3935.252302062599, 4126.576331165743, 4129.15352352767, 4130.380442933524, 4144.647704945053, 4647.489565891099, 4652.720836749806, 4653.0, 4654.697444666086, 4669.39297891272, 5398.865028374244, 5401.405845357008, 5459.372172200247, 5474.0, 5474.562035037187, 1344.764666183414, 1350.3180893648644, 1402.3759427055068, 1416.992915035439, 1427.079533700757, 965.6137544981923, 971.1842052675786, 990.9108180263811, 992.4987881120132, 993.3295025857517, 5246.108161612535, 5250.0, 5257.290265814143, 5259.158534634516, 5263.157894736823, 5487.204355368449, 5500.614956953055, 5505.449455054542, 5507.944920550824, 5547.528460080857, 5052.191649336089, 5225.817096401608, 5242.633015688865, 5257.78968841242, 5309.628326017219, 2934.6478422589425, 2958.778091643135, 2965.3476235228213, 2973.334932437842, 2973.435047340998, 5775.393583673737, 5794.449527294901, 5811.389804070596, 5816.970915145397, 5823.650580965155, 5596.244506991504, 5641.915371269434, 5689.630174038674, 5699.772009119672, 5713.628614140068, 5745.0, 5749.798757043483, 5749.9712501437225, 5751.913721294184, 5757.8560535986935, 5361.544268737201, 5559.8308963890195, 5566.805161819317, 5602.607817452739, 5630.0, 5515.7242137893745, 5540.390557038803, 5546.58400619947, 5549.361823390362, 5579.330480342385, 5781.768729250783, 5787.768489260382, 5797.304323481209, 5803.506701930383, 5805.82582522525, 3924.803759811941, 4040.1717647881524, 4051.2377115954655, 4063.89840253996, 4065.8780236592947, 5282.841514754564, 5544.0, 5549.833504994856, 5551.528120109836, 5581.944180558305, 5247.737613119405, 5393.27190829233, 5409.5672346213, 5440.183972404171, 5453.454654534515, 5413.242146099628, 5434.2392065110125, 5435.374931882884, 5439.884823611229, 5457.672539647634, 5182.97408512955, 5368.8389348319615, 5377.435369286169, 5381.4169198785585, 5430.565554755689, 5433.5109840113, 5458.5087342139395, 5459.918101228405, 5460.2355670207, 5465.754041068082, 5229.869253268699, 5317.8404647860625, 5339.519443250126, 5349.251104845247, 5364.865878353073], "value": 4190.191481920917, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [754.9056367954006, 797.1828875402713, 800.7002397127427, 810.6676262732279, 817.8936738224033, 14746.926265368686, 15874.761878571831, 16539.503814885542, 16540.421085262034, 16551.255193516292, 15770.0, 15784.526464206063, 15874.761878571831, 15890.126043067627, 15909.52271431856, 663.3466035954581, 805.2350267246125, 824.9752507424787, 825.038829763325, 825.0553116681397, 794.0352471746827, 800.9359251259885, 811.8011087283594, 834.4951304460805, 835.3943391041477, 843.472829481574, 843.9956451822312, 844.8901642786429, 845.0071166379511, 845.8815765792793, 681.9386255237052, 847.3179090831878, 847.4788005376711, 848.6732607945954, 850.370725663008, 608.6135304081896, 613.4846728747829, 618.6226401894841, 629.7166275176144, 629.8393909553081, 14439.855601443956, 14540.418383264763, 14558.781618275734, 14567.0, 14574.927125364411, 14043.929780351134, 14349.641258968504, 14686.0, 14704.77585933785, 15092.16993065381, 13131.212127272394, 13136.86863131366, 13245.668858278525, 13536.05247632666, 13591.592252232449, 4408.493023302329, 4463.174312752151, 4482.260427029569, 4494.348319493655, 4546.704464209849, 80971.0, 81697.59151204205, 82302.58848705718, 83678.21378755204, 88620.11379886183, 11417.37204453763, 11459.369734664508, 11490.54037838477, 11513.136514761427, 11794.705132371759, 21701.891490542446, 21777.78222217789, 21792.564148716938, 21794.455138621342, 21824.89087554552, 8344.123866994, 8459.830803383898, 8747.693830715894, 8819.338549608805, 8832.381733278737, 4789.114013907439, 4879.658423910292, 4905.0, 4936.456989731127, 5045.772940217626, 3248.447763880146, 3321.335732853439, 3322.186064414234, 3355.9496607550905, 3358.126887009395, 580.2080160580861, 586.9002269614176, 591.9408059194046, 594.1236675903009, 604.1753007145215, 637.8022812928007, 654.6693919570587, 686.7802303262907, 701.7649087555624, 702.1048163591462, 9650.227981761442, 9676.467794271382, 9690.70927872165, 9736.855146439395, 9927.950360248153, 630.4074170279922, 638.4541217259269, 695.1775790291433, 700.7827573452246, 702.118840854724, 4301.913961720748, 4338.652907767371, 4627.329037289574, 4729.196036673774, 4733.763311834395, 79798.60100699459, 94335.0, 136876.0, 137569.0, 141662.0, 111982.44008779904, 113893.0, 114458.0, 114467.0, 120348.77907325588, 93270.53364733269, 99950.0, 100321.49839250756, 100878.49560752149, 101247.0, 8131.837363252584, 8715.738527844174, 8959.596818143069, 8980.955095224483, 9116.316276279173, 50670.493295066575, 53695.46304537061, 54307.728461359024, 54997.725011374685, 55698.72150639383, 80769.0, 81762.32069557003, 82206.17793821986, 84182.0, 85031.14968850232, 10976.341419514854, 11356.545738170711, 11423.600173993871, 11563.88436115628, 11678.0, 12674.176178548365, 12688.6827829305, 12990.805137922749, 13236.470541178245, 13561.389737462036, 12258.20321679088, 12724.809127863275, 12759.48962041508, 12895.613131606067, 13093.934530327288, 12255.0, 12523.373831308216, 12621.684457888627, 13089.476420943056, 13212.603621891358, 11800.17398782077, 12080.577179798665, 12598.05514586428, 12609.30648814324, 12618.873811262138, 10224.28430009922, 10401.739956501147, 10749.355038697704, 10750.892491075301, 11076.833847492133, 8437.873431898404, 9539.570719317786, 10089.697309080739, 10236.897631023594, 10323.94838025805], "value": 7551.520308575193, "unit": "score"}], "name": "dromaeo_css", "value": 7096.518846711815, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 130.0, 110.0, 111.0, 111.0, 111.0, 111.0, 112.0, 114.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 125.0, 144.0, 185.0, 118.0, 149.0, 152.0, 126.0, 176.0, 123.0], "value": 144.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 161.0, 160.0, 161.0, 162.0, 162.0, 164.0, 160.0, 162.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 179.0, 77.0, 75.0, 75.0, 76.0, 174.0, 76.0], "value": 96.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 145.0, 83.0, 83.0, 83.0, 144.0, 83.0, 81.0, 141.0], "value": 100.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 145.0, 148.0, 150.0, 146.0, 146.0, 145.0, 146.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 53.0, 53.0, 52.0, 53.0, 52.0, 52.0, 52.0, 52.0], "value": 52.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 61.0, 61.0, 62.0, 61.0, 63.0, 62.0, 63.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 79.0, 84.0, 78.0, 79.0, 78.0, 77.0, 83.0, 77.0, 78.0], "value": 79.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 122.0, 125.0, 132.0, 132.0, 126.0, 134.0, 126.0, 168.0, 129.0], "value": 132.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 162.0, 163.0, 166.0, 161.0, 163.0, 162.0, 161.0, 162.0], "value": 162.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 64.0, 64.0, 64.0, 67.0, 64.0, 63.0, 63.0], "value": 64.4, "unit": "score"}], "name": "kraken", "value": 1528.9000000000003, "alertThreshold": 2.0}]} 05:46:46 INFO - Return code: 0 05:46:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:46:46 INFO - # TBPL SUCCESS # 05:46:46 INFO - Running post-action listener: _resource_record_post_action 05:46:46 INFO - [mozharness: 2016-08-27 12:46:46.338659Z] Finished run-tests step (success) 05:46:46 INFO - Running post-run listener: _resource_record_post_run 05:46:46 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 418082816; Read time: 8; Write time: 391044 05:46:46 INFO - TinderboxPrint: CPU usage
13.1% 05:46:46 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 05:46:46 INFO - TinderboxPrint: I/O write bytes / time
418,082,816 / 391,044 05:46:46 INFO - TinderboxPrint: CPU idle
8,295.4 (86.9%) 05:46:46 INFO - TinderboxPrint: CPU user
1,195.7 (12.5%) 05:46:46 INFO - TinderboxPrint: Swap in / out
0 / 0 05:46:46 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 128811008; Read time: 0; Write time: 110400 05:46:46 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 288743424; Read time: 0; Write time: 280612 05:46:46 INFO - Running post-run listener: _upload_blobber_files 05:46:46 INFO - Blob upload gear active. 05:46:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:46:46 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 05:46:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:46:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:46:47 INFO - (blobuploader) - INFO - Open directory for files ... 05:46:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:46:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:46:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:46:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:46:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:46:48 INFO - (blobuploader) - INFO - Done attempting. 05:46:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:46:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:46:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:46:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:46:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:46:51 INFO - (blobuploader) - INFO - Done attempting. 05:46:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:46:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:46:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:46:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:46:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:46:51 INFO - (blobuploader) - INFO - Done attempting. 05:46:51 INFO - (blobuploader) - INFO - Iteration through files over. 05:46:52 INFO - Return code: 0 05:46:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:46:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:46:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/156e3dd3ee2f39c936ec0a351fa0c8737c42d6e97f26a430312630bbf5a0fd6bb428d13f54508b7c2f2a099d475a587c0ae98bf38ad7cd2feb6557631535e58b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/07621dedee421fcd1eb7576541b6ba8fe30b8a551478bb86eb119e4e63ff4d9c9e03427d300f590e894b3782eb1e51eb4b6237487a6eaf5b85b7370d36c8d526", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/22d209916153b4c1093b31b9a3adc09201cfaf3b7a5ec089e220fb1853cda554f76f82b397bb9fdc116199814cb960330961e618d6af60c4d243db9f30e80c81"} 05:46:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:46:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:46:52 INFO - Contents: 05:46:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/156e3dd3ee2f39c936ec0a351fa0c8737c42d6e97f26a430312630bbf5a0fd6bb428d13f54508b7c2f2a099d475a587c0ae98bf38ad7cd2feb6557631535e58b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/07621dedee421fcd1eb7576541b6ba8fe30b8a551478bb86eb119e4e63ff4d9c9e03427d300f590e894b3782eb1e51eb4b6237487a6eaf5b85b7370d36c8d526", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/22d209916153b4c1093b31b9a3adc09201cfaf3b7a5ec089e220fb1853cda554f76f82b397bb9fdc116199814cb960330961e618d6af60c4d243db9f30e80c81"} 05:46:52 INFO - Running post-run listener: copy_logs_to_upload_dir 05:46:52 INFO - Copying logs to upload dir... 05:46:52 INFO - mkdir: /builds/slave/test/build/upload/logs 05:46:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.438823 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-08-27 05:46:50.916242) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-27 05:46:50.919517) ========= 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=836cfdc75598d54cb747368e000001a9-1472300097.879568-1396000819 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/156e3dd3ee2f39c936ec0a351fa0c8737c42d6e97f26a430312630bbf5a0fd6bb428d13f54508b7c2f2a099d475a587c0ae98bf38ad7cd2feb6557631535e58b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/07621dedee421fcd1eb7576541b6ba8fe30b8a551478bb86eb119e4e63ff4d9c9e03427d300f590e894b3782eb1e51eb4b6237487a6eaf5b85b7370d36c8d526", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/22d209916153b4c1093b31b9a3adc09201cfaf3b7a5ec089e220fb1853cda554f76f82b397bb9fdc116199814cb960330961e618d6af60c4d243db9f30e80c81"} build_url:https://queue.taskcluster.net/v1/task/JdZOMC-nQk-582FFdTeoEw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011294 build_url: 'https://queue.taskcluster.net/v1/task/JdZOMC-nQk-582FFdTeoEw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/156e3dd3ee2f39c936ec0a351fa0c8737c42d6e97f26a430312630bbf5a0fd6bb428d13f54508b7c2f2a099d475a587c0ae98bf38ad7cd2feb6557631535e58b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/07621dedee421fcd1eb7576541b6ba8fe30b8a551478bb86eb119e4e63ff4d9c9e03427d300f590e894b3782eb1e51eb4b6237487a6eaf5b85b7370d36c8d526", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/22d209916153b4c1093b31b9a3adc09201cfaf3b7a5ec089e220fb1853cda554f76f82b397bb9fdc116199814cb960330961e618d6af60c4d243db9f30e80c81"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-27 05:46:50.946982) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 05:46:50.947713) ========= 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=836cfdc75598d54cb747368e000001a9-1472300097.879568-1396000819 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004446 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 05:46:51.028246) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-27 05:46:51.028587) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-27 05:46:51.028927) ========= ========= Total master_lag: 0.17 =========