builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-032 starttime: 1469130332.62 results: success (0) buildid: 20160721083037 builduid: 4990d6435e6d4ffd826392cf6e9b3247 revision: f5154aaeaec4546dd04c66ac61a0d0ee69f4dfdf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 12:45:32.618209) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 12:45:32.618950) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 12:45:32.619222) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 12:45:32.634569) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 12:45:32.635233) ========= 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=745a4373a2a16df560f216e000000264-1469130332.78696-1346484126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-21 12:45:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2016-07-21 12:45:33 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117785 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 12:45:32.768220) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 12:45:32.768562) ========= 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=745a4373a2a16df560f216e000000264-1469130332.78696-1346484126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019326 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 12:45:32.818262) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-21 12:45:32.818671) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f5154aaeaec4546dd04c66ac61a0d0ee69f4dfdf --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 f5154aaeaec4546dd04c66ac61a0d0ee69f4dfdf --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=745a4373a2a16df560f216e000000264-1469130332.78696-1346484126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-21 12:45:33,148 truncating revision to first 12 chars 2016-07-21 12:45:33,148 Setting DEBUG logging. 2016-07-21 12:45:33,148 attempt 1/10 2016-07-21 12:45:33,148 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f5154aaeaec4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-21 12:45:34,541 unpacking tar archive at: fx-team-f5154aaeaec4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.803658 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-21 12:45:34.635745) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 12:45:34.636069) ========= script_repo_revision: f5154aaeaec4546dd04c66ac61a0d0ee69f4dfdf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 12:45:34.636457) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 12:45:34.636732) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 12:45:34.646584) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-07-21 12:45:34.646947) ========= /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=745a4373a2a16df560f216e000000264-1469130332.78696-1346484126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:45:35 INFO - MultiFileLogger online at 20160721 12:45:35 in /builds/slave/test 12:45:35 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 12:45:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:45:35 INFO - {'append_to_log': False, 12:45:35 INFO - 'base_work_dir': '/builds/slave/test', 12:45:35 INFO - 'blob_upload_branch': 'Fx-Team', 12:45:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:45:35 INFO - 'branch': 'Fx-Team', 12:45:35 INFO - 'buildbot_json_path': 'buildprops.json', 12:45:35 INFO - 'config_files': ('talos/linux_config.py',), 12:45:35 INFO - 'default_actions': ('clobber', 12:45:35 INFO - 'read-buildbot-config', 12:45:35 INFO - 'download-and-extract', 12:45:35 INFO - 'populate-webroot', 12:45:35 INFO - 'create-virtualenv', 12:45:35 INFO - 'install', 12:45:35 INFO - 'run-tests'), 12:45:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:45:35 INFO - 'download_minidump_stackwalk': True, 12:45:35 INFO - 'download_symbols': 'ondemand', 12:45:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:45:35 INFO - 'tooltool.py': '/tools/tooltool.py', 12:45:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:45:35 INFO - '/tools/misc-python/virtualenv.py')}, 12:45:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:45:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:45:35 INFO - 'installer_path': 'installer.exe', 12:45:35 INFO - 'log_level': 'info', 12:45:35 INFO - 'log_name': 'talos', 12:45:35 INFO - 'log_to_console': True, 12:45:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:45:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:45:35 INFO - 'opt_config_files': (), 12:45:35 INFO - 'pip_index': False, 12:45:35 INFO - 'sps_profile': False, 12:45:35 INFO - 'sps_profile_interval': 0, 12:45:35 INFO - 'suite': 'dromaeojs', 12:45:35 INFO - 'system_bits': '32', 12:45:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:45:35 INFO - 'title': 'talos-linux64-ix-032', 12:45:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:45:35 INFO - 'use_talos_json': True, 12:45:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:45:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:45:35 INFO - 'work_dir': 'build'} 12:45:35 INFO - [mozharness: 2016-07-21 19:45:35.069154Z] Running clobber step. 12:45:35 INFO - Running pre-action listener: _resource_record_pre_action 12:45:35 INFO - Running main action method: clobber 12:45:35 INFO - rmtree: /builds/slave/test/build 12:45:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:45:35 INFO - Running post-action listener: _resource_record_post_action 12:45:35 INFO - [mozharness: 2016-07-21 19:45:35.546881Z] Finished clobber step (success) 12:45:35 INFO - [mozharness: 2016-07-21 19:45:35.546983Z] Running read-buildbot-config step. 12:45:35 INFO - Running pre-action listener: _resource_record_pre_action 12:45:35 INFO - Running main action method: read_buildbot_config 12:45:35 INFO - Using buildbot properties: 12:45:35 INFO - { 12:45:35 INFO - "project": "", 12:45:35 INFO - "product": "firefox", 12:45:35 INFO - "script_repo_revision": "production", 12:45:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:45:35 INFO - "repository": "", 12:45:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 12:45:35 INFO - "buildid": "20160721083037", 12:45:35 INFO - "pgo_build": "True", 12:45:35 INFO - "basedir": "/builds/slave/test", 12:45:35 INFO - "buildnumber": 1344, 12:45:35 INFO - "slavename": "talos-linux64-ix-032", 12:45:35 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:45:35 INFO - "platform": "ubuntu64_hw", 12:45:35 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 12:45:35 INFO - "branch": "fx-team", 12:45:35 INFO - "repo_path": "integration/fx-team", 12:45:35 INFO - "revision": "f5154aaeaec4546dd04c66ac61a0d0ee69f4dfdf", 12:45:35 INFO - "stage_platform": "linux64-pgo", 12:45:35 INFO - "builduid": "4990d6435e6d4ffd826392cf6e9b3247", 12:45:35 INFO - "slavebuilddir": "test" 12:45:35 INFO - } 12:45:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 12:45:35 INFO - Running post-action listener: _resource_record_post_action 12:45:35 INFO - [mozharness: 2016-07-21 19:45:35.549435Z] Finished read-buildbot-config step (success) 12:45:35 INFO - [mozharness: 2016-07-21 19:45:35.549524Z] Running download-and-extract step. 12:45:35 INFO - Running pre-action listener: _resource_record_pre_action 12:45:35 INFO - Running main action method: download_and_extract 12:45:35 INFO - mkdir: /builds/slave/test/build/tests 12:45:35 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:35 INFO - https://queue.taskcluster.net/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:45:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:45:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:45:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:45:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:45:36 INFO - Downloaded 1361 bytes. 12:45:36 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:45:36 INFO - Using the following test package requirements: 12:45:36 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:45:36 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:45:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:45:36 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:45:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:45:36 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:45:36 INFO - u'jsshell-linux-x86_64.zip'], 12:45:36 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:45:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:45:36 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:45:36 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:45:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:45:36 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:45:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:45:36 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:45:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:45:36 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:45:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:45:36 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:45: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:36 INFO - https://queue.taskcluster.net/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:45:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:45:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:45:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:45:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:45:37 INFO - Downloaded 24306908 bytes. 12:45:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:45:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:45:38 INFO - Return code: 0 12:45:38 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:45: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:38 INFO - https://queue.taskcluster.net/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:45:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:45:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:45:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:45:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:45:39 INFO - Downloaded 24306908 bytes. 12:45:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:45:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:45:41 INFO - Return code: 0 12:45:41 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:41 INFO - https://queue.taskcluster.net/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:45:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:45:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:45:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:45:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:45:42 INFO - Downloaded 14403317 bytes. 12:45:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:45:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 12:45:42 INFO - Return code: 0 12:45: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:42 INFO - https://queue.taskcluster.net/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:45:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:45:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:45:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:45:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:45:43 INFO - Downloaded 60857818 bytes. 12:45:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:45:43 INFO - mkdir: /builds/slave/test/properties 12:45:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:45:43 INFO - Writing to file /builds/slave/test/properties/build_url 12:45:43 INFO - Contents: 12:45:43 INFO - build_url:https://queue.taskcluster.net/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:45:44 INFO - Running post-action listener: _resource_record_post_action 12:45:44 INFO - Running post-action listener: set_extra_try_arguments 12:45:44 INFO - [mozharness: 2016-07-21 19:45:44.523091Z] Finished download-and-extract step (success) 12:45:44 INFO - [mozharness: 2016-07-21 19:45:44.523321Z] Running populate-webroot step. 12:45:44 INFO - Running pre-action listener: _resource_record_pre_action 12:45:44 INFO - Running main action method: populate_webroot 12:45:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:45:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:45:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:45:44 INFO - '--tppagecycles', 12:45:44 INFO - '7'], 12:45:44 INFO - 'tests': ['tsvgm']}}, 12:45:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:45:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:45:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:45:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:45:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:45:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:45:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:45:44 INFO - 'talos_options': ['--disable-e10s'], 12:45:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:45:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:45:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:45:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:45:44 INFO - 'talos_options': ['--disable-e10s'], 12:45:44 INFO - 'tests': ['damp', 'tps']}, 12:45:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:45:44 INFO - 'tests': ['damp', 'tps']}, 12:45:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:45:44 INFO - 'tests': ['dromaeo_dom']}, 12:45:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:45:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:45:44 INFO - 'tests': ['basic_compositor_video']}, 12:45:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:45:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:45:44 INFO - 'tests': ['a11yr', 12:45:44 INFO - 'ts_paint', 12:45:44 INFO - 'tpaint', 12:45:44 INFO - 'sessionrestore', 12:45:44 INFO - 'sessionrestore_no_auto_restore', 12:45:44 INFO - 'tabpaint']}, 12:45:44 INFO - 'other-e10s': {'tests': ['a11yr', 12:45:44 INFO - 'ts_paint', 12:45:44 INFO - 'tpaint', 12:45:44 INFO - 'sessionrestore', 12:45:44 INFO - 'sessionrestore_no_auto_restore', 12:45:44 INFO - 'tabpaint']}, 12:45:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:45:44 INFO - 'ts_paint', 12:45:44 INFO - 'tpaint', 12:45:44 INFO - 'sessionrestore', 12:45:44 INFO - 'sessionrestore_no_auto_restore', 12:45:44 INFO - 'tabpaint']}, 12:45:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:45:44 INFO - 'ts_paint', 12:45:44 INFO - 'tpaint', 12:45:44 INFO - 'sessionrestore', 12:45:44 INFO - 'sessionrestore_no_auto_restore', 12:45:44 INFO - 'tabpaint']}, 12:45:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:45:44 INFO - 'tests': ['a11yr', 12:45:44 INFO - 'ts_paint', 12:45:44 INFO - 'tpaint', 12:45:44 INFO - 'sessionrestore', 12:45:44 INFO - 'sessionrestore_no_auto_restore', 12:45:44 INFO - 'tabpaint']}, 12:45:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:45:44 INFO - 'tests': ['a11yr', 12:45:44 INFO - 'ts_paint', 12:45:44 INFO - 'tpaint', 12:45:44 INFO - 'sessionrestore', 12:45:44 INFO - 'sessionrestore_no_auto_restore', 12:45:44 INFO - 'tabpaint']}, 12:45:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:45:44 INFO - 'tests': ['tsvgx', 12:45:44 INFO - 'tsvgr_opacity', 12:45:44 INFO - 'tart', 12:45:44 INFO - 'tscrollx', 12:45:44 INFO - 'cart']}, 12:45:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:45:44 INFO - 'tsvgr_opacity', 12:45:44 INFO - 'tart', 12:45:44 INFO - 'tscrollx', 12:45:44 INFO - 'cart']}, 12:45:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:45:44 INFO - 'talos_options': ['--disable-e10s'], 12:45:44 INFO - 'tests': ['tp5o']}, 12:45:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:45:44 INFO - 'tests': ['tp5o']}, 12:45:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:45:44 INFO - 'talos_options': ['--disable-e10s', 12:45:44 INFO - '--xperf_path', 12:45:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:45:44 INFO - 'tests': ['tp5n']}, 12:45:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:45:44 INFO - 'talos_options': ['--xperf_path', 12:45:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:45:44 INFO - 'tests': ['tp5n']}}, 12:45:44 INFO - 'talos.zip': {'path': '', 12:45:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:45:44 INFO - Running post-action listener: _resource_record_post_action 12:45:44 INFO - [mozharness: 2016-07-21 19:45:44.544991Z] Finished populate-webroot step (success) 12:45:44 INFO - [mozharness: 2016-07-21 19:45:44.545115Z] Running create-virtualenv step. 12:45:44 INFO - Running pre-action listener: _resource_record_pre_action 12:45:44 INFO - Running main action method: create_virtualenv 12:45:44 INFO - Creating virtualenv /builds/slave/test/build/venv 12:45:44 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 12:45:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:45:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:45:44 INFO - Using real prefix '/usr' 12:45:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:45:45 INFO - Installing distribute.............................................................................................................................................................................................done. 12:45:47 INFO - Installing pip.................done. 12:45:47 INFO - Return code: 0 12:45:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:45:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x233b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2499180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24973b0>, '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 0x24982b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2498740>, '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': '745a4373a2a16df560f216e000000264-1469130332.78696-1346484126', '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 12:45:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:45:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:45:47 INFO - Using env: {'DISPLAY': ':0', 12:45:47 INFO - 'HOME': '/home/cltbld', 12:45:47 INFO - 'LANG': 'en_US.UTF-8', 12:45:47 INFO - 'LANGUAGE': 'en_US:en', 12:45:47 INFO - 'LOGNAME': 'cltbld', 12:45:47 INFO - 'MAIL': '/var/mail/cltbld', 12:45:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:47 INFO - 'MOZ_NO_REMOTE': '1', 12:45:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:45:47 INFO - 'NO_EM_RESTART': '1', 12:45:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:45:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:47 INFO - 'PWD': '/builds/slave/test', 12:45:47 INFO - 'SHELL': '/bin/bash', 12:45:47 INFO - 'SHLVL': '1', 12:45:47 INFO - 'TERM': 'linux', 12:45:47 INFO - 'TMOUT': '86400', 12:45:47 INFO - 'USER': 'cltbld', 12:45:47 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469130332.78696-1346484126', 12:45:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:47 INFO - '_': '/tools/buildbot/bin/python'} 12:45:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:47 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 12:45:47 INFO - Cleaning up... 12:45:47 INFO - Return code: 0 12:45:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:45:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21d8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x233b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2499180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24973b0>, '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 0x24982b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2498740>, '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': '745a4373a2a16df560f216e000000264-1469130332.78696-1346484126', '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 12:45:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:45:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:45:47 INFO - Using env: {'DISPLAY': ':0', 12:45:47 INFO - 'HOME': '/home/cltbld', 12:45:47 INFO - 'LANG': 'en_US.UTF-8', 12:45:47 INFO - 'LANGUAGE': 'en_US:en', 12:45:47 INFO - 'LOGNAME': 'cltbld', 12:45:47 INFO - 'MAIL': '/var/mail/cltbld', 12:45:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:47 INFO - 'MOZ_NO_REMOTE': '1', 12:45:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:45:47 INFO - 'NO_EM_RESTART': '1', 12:45:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:45:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:47 INFO - 'PWD': '/builds/slave/test', 12:45:47 INFO - 'SHELL': '/bin/bash', 12:45:47 INFO - 'SHLVL': '1', 12:45:47 INFO - 'TERM': 'linux', 12:45:47 INFO - 'TMOUT': '86400', 12:45:47 INFO - 'USER': 'cltbld', 12:45:47 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469130332.78696-1346484126', 12:45:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:47 INFO - '_': '/tools/buildbot/bin/python'} 12:45:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:47 INFO - Downloading/unpacking psutil>=3.1.1 12:45: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 12:45: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 12:45: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 12:45: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 12:45: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 12:45: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 12:45:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:45:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:45:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:45:49 INFO - Installing collected packages: psutil 12:45:49 INFO - Running setup.py install for psutil 12:45:49 INFO - building 'psutil._psutil_linux' extension 12:45:49 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 12:45:49 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 12:45:49 INFO - building 'psutil._psutil_posix' extension 12:45:49 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 12:45:50 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 12:45:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:45:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:45:50 INFO - Successfully installed psutil 12:45:50 INFO - Cleaning up... 12:45:50 INFO - Return code: 0 12:45:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:45:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x233b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2499180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24973b0>, '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 0x24982b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2498740>, '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': '745a4373a2a16df560f216e000000264-1469130332.78696-1346484126', '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 12:45:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:45:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:45:50 INFO - Using env: {'DISPLAY': ':0', 12:45:50 INFO - 'HOME': '/home/cltbld', 12:45:50 INFO - 'LANG': 'en_US.UTF-8', 12:45:50 INFO - 'LANGUAGE': 'en_US:en', 12:45:50 INFO - 'LOGNAME': 'cltbld', 12:45:50 INFO - 'MAIL': '/var/mail/cltbld', 12:45:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:50 INFO - 'MOZ_NO_REMOTE': '1', 12:45:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:45:50 INFO - 'NO_EM_RESTART': '1', 12:45:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:45:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:50 INFO - 'PWD': '/builds/slave/test', 12:45:50 INFO - 'SHELL': '/bin/bash', 12:45:50 INFO - 'SHLVL': '1', 12:45:50 INFO - 'TERM': 'linux', 12:45:50 INFO - 'TMOUT': '86400', 12:45:50 INFO - 'USER': 'cltbld', 12:45:50 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469130332.78696-1346484126', 12:45:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:50 INFO - '_': '/tools/buildbot/bin/python'} 12:45:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:45:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:45:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:45:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:45:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:45:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:45:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:45:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:45:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:45:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:45:52 INFO - Installing collected packages: mozsystemmonitor 12:45:52 INFO - Running setup.py install for mozsystemmonitor 12:45:52 INFO - Successfully installed mozsystemmonitor 12:45:52 INFO - Cleaning up... 12:45:52 INFO - Return code: 0 12:45:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21d8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x233b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2499180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24973b0>, '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 0x24982b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2498740>, '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': '745a4373a2a16df560f216e000000264-1469130332.78696-1346484126', '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 12:45:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:45:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:45:52 INFO - Using env: {'DISPLAY': ':0', 12:45:52 INFO - 'HOME': '/home/cltbld', 12:45:52 INFO - 'LANG': 'en_US.UTF-8', 12:45:52 INFO - 'LANGUAGE': 'en_US:en', 12:45:52 INFO - 'LOGNAME': 'cltbld', 12:45:52 INFO - 'MAIL': '/var/mail/cltbld', 12:45:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:52 INFO - 'MOZ_NO_REMOTE': '1', 12:45:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:45:52 INFO - 'NO_EM_RESTART': '1', 12:45:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:45:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:52 INFO - 'PWD': '/builds/slave/test', 12:45:52 INFO - 'SHELL': '/bin/bash', 12:45:52 INFO - 'SHLVL': '1', 12:45:52 INFO - 'TERM': 'linux', 12:45:52 INFO - 'TMOUT': '86400', 12:45:52 INFO - 'USER': 'cltbld', 12:45:52 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469130332.78696-1346484126', 12:45:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:52 INFO - '_': '/tools/buildbot/bin/python'} 12:45:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:52 INFO - Downloading/unpacking jsonschema==2.5.1 12:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:45:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:45:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:45:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:45:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:45:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:45:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:45:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:45:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:45:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:45:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:45:54 INFO - Downloading functools32-3.2.3-2.tar.gz 12:45:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:45:54 INFO - warning: no files found matching '*.txt' 12:45:54 INFO - no previously-included directories found matching 'build' 12:45:54 INFO - no previously-included directories found matching 'dist' 12:45:54 INFO - no previously-included directories found matching '.git*' 12:45:54 INFO - Installing collected packages: jsonschema, functools32 12:45:54 INFO - Running setup.py install for functools32 12:45:55 INFO - warning: no files found matching '*.txt' 12:45:55 INFO - no previously-included directories found matching 'build' 12:45:55 INFO - no previously-included directories found matching 'dist' 12:45:55 INFO - no previously-included directories found matching '.git*' 12:45:55 INFO - Successfully installed jsonschema functools32 12:45:55 INFO - Cleaning up... 12:45:55 INFO - Return code: 0 12:45:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:45:55 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:55 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:55 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 0x21d8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x233b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2499180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24973b0>, '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 0x24982b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2498740>, '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': '745a4373a2a16df560f216e000000264-1469130332.78696-1346484126', '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 12:45:55 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 12:45:55 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 12:45:55 INFO - Using env: {'DISPLAY': ':0', 12:45:55 INFO - 'HOME': '/home/cltbld', 12:45:55 INFO - 'LANG': 'en_US.UTF-8', 12:45:55 INFO - 'LANGUAGE': 'en_US:en', 12:45:55 INFO - 'LOGNAME': 'cltbld', 12:45:55 INFO - 'MAIL': '/var/mail/cltbld', 12:45:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:55 INFO - 'MOZ_NO_REMOTE': '1', 12:45:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:45:55 INFO - 'NO_EM_RESTART': '1', 12:45:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:45:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:55 INFO - 'PWD': '/builds/slave/test', 12:45:55 INFO - 'SHELL': '/bin/bash', 12:45:55 INFO - 'SHLVL': '1', 12:45:55 INFO - 'TERM': 'linux', 12:45:55 INFO - 'TMOUT': '86400', 12:45:55 INFO - 'USER': 'cltbld', 12:45:55 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469130332.78696-1346484126', 12:45:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:55 INFO - '_': '/tools/buildbot/bin/python'} 12:45:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:55 INFO - Downloading/unpacking blobuploader==1.2.4 12:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:45:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:45:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:45:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:45:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:45:57 INFO - Downloading blobuploader-1.2.4.tar.gz 12:45:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:45:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:45:57 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 12:45:57 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 12:45:57 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 12:45:57 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 12:45:57 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 12:45:57 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 12:45:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:45:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:45:57 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 12:45:57 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 12:45:57 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 12:45:57 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 12:45:57 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 12:45:57 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 12:45:57 INFO - Downloading docopt-0.6.1.tar.gz 12:45:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:45:57 INFO - Installing collected packages: blobuploader, requests, docopt 12:45:57 INFO - Running setup.py install for blobuploader 12:45:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:45:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:45:58 INFO - Running setup.py install for requests 12:45:58 INFO - Running setup.py install for docopt 12:45:58 INFO - Successfully installed blobuploader requests docopt 12:45:58 INFO - Cleaning up... 12:45:58 INFO - Return code: 0 12:45:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:45:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:58 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 0x21d8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x233b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2499180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24973b0>, '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 0x24982b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2498740>, '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': '745a4373a2a16df560f216e000000264-1469130332.78696-1346484126', '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 12:45:58 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 12:45:58 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 12:45:58 INFO - Using env: {'DISPLAY': ':0', 12:45:58 INFO - 'HOME': '/home/cltbld', 12:45:58 INFO - 'LANG': 'en_US.UTF-8', 12:45:58 INFO - 'LANGUAGE': 'en_US:en', 12:45:58 INFO - 'LOGNAME': 'cltbld', 12:45:58 INFO - 'MAIL': '/var/mail/cltbld', 12:45:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:58 INFO - 'MOZ_NO_REMOTE': '1', 12:45:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:45:58 INFO - 'NO_EM_RESTART': '1', 12:45:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:45:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:58 INFO - 'PWD': '/builds/slave/test', 12:45:58 INFO - 'SHELL': '/bin/bash', 12:45:58 INFO - 'SHLVL': '1', 12:45:58 INFO - 'TERM': 'linux', 12:45:58 INFO - 'TMOUT': '86400', 12:45:58 INFO - 'USER': 'cltbld', 12:45:58 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469130332.78696-1346484126', 12:45:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:58 INFO - '_': '/tools/buildbot/bin/python'} 12:45:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:45:58 INFO - Running setup.py (path:/tmp/pip-wGJnEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:45:58 INFO - Running setup.py (path:/tmp/pip-bgwqgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:45:58 INFO - Running setup.py (path:/tmp/pip-Fl15WH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:45:59 INFO - Running setup.py (path:/tmp/pip-AtjvGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:45:59 INFO - Running setup.py (path:/tmp/pip-tmuj8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:45:59 INFO - Running setup.py (path:/tmp/pip-73i7yf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:45:59 INFO - Running setup.py (path:/tmp/pip-heiskC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:45:59 INFO - Running setup.py (path:/tmp/pip-Fz2yS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:45:59 INFO - Running setup.py (path:/tmp/pip-cPtGDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:45:59 INFO - Running setup.py (path:/tmp/pip-9gnyS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:45:59 INFO - Running setup.py (path:/tmp/pip-i1lvQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:45:59 INFO - Running setup.py (path:/tmp/pip-j4Jao_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:45:59 INFO - Running setup.py (path:/tmp/pip-HR0UzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:45:59 INFO - Running setup.py (path:/tmp/pip-1B0MPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:45:59 INFO - Running setup.py (path:/tmp/pip-tOSpQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:45:59 INFO - Running setup.py (path:/tmp/pip-2nm278-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:45:59 INFO - Running setup.py (path:/tmp/pip-RcFign-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:46:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:46:00 INFO - Running setup.py install for manifestparser 12:46:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:46:00 INFO - Running setup.py install for mozcrash 12:46:00 INFO - Running setup.py install for mozdebug 12:46:00 INFO - Running setup.py install for mozdevice 12:46:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:46:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:46:00 INFO - Running setup.py install for mozfile 12:46:00 INFO - Running setup.py install for mozhttpd 12:46:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:46:00 INFO - Running setup.py install for mozinfo 12:46:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:46:00 INFO - Running setup.py install for mozInstall 12:46:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:46:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:46:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:46:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:46:00 INFO - Running setup.py install for mozleak 12:46:00 INFO - Running setup.py install for mozlog 12:46:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:46:01 INFO - Running setup.py install for moznetwork 12:46:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:46:01 INFO - Running setup.py install for mozprocess 12:46:01 INFO - Running setup.py install for mozprofile 12:46:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:46:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:46:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:46:01 INFO - Running setup.py install for mozrunner 12:46:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:46:01 INFO - Running setup.py install for mozscreenshot 12:46:01 INFO - Running setup.py install for moztest 12:46:01 INFO - Running setup.py install for mozversion 12:46:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:46:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:46:01 INFO - Cleaning up... 12:46:01 INFO - Return code: 0 12:46:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:46:01 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:46:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:46:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:46:01 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:46:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:46:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:46:01 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 0x21d8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x233b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2499180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24973b0>, '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 0x24982b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2498740>, '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': '745a4373a2a16df560f216e000000264-1469130332.78696-1346484126', '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 12:46:01 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 12:46:01 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 12:46:01 INFO - Using env: {'DISPLAY': ':0', 12:46:01 INFO - 'HOME': '/home/cltbld', 12:46:01 INFO - 'LANG': 'en_US.UTF-8', 12:46:01 INFO - 'LANGUAGE': 'en_US:en', 12:46:01 INFO - 'LOGNAME': 'cltbld', 12:46:01 INFO - 'MAIL': '/var/mail/cltbld', 12:46:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:46:01 INFO - 'MOZ_NO_REMOTE': '1', 12:46:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:46:01 INFO - 'NO_EM_RESTART': '1', 12:46:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:46:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:46:01 INFO - 'PWD': '/builds/slave/test', 12:46:01 INFO - 'SHELL': '/bin/bash', 12:46:01 INFO - 'SHLVL': '1', 12:46:01 INFO - 'TERM': 'linux', 12:46:01 INFO - 'TMOUT': '86400', 12:46:01 INFO - 'USER': 'cltbld', 12:46:01 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469130332.78696-1346484126', 12:46:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:46:01 INFO - '_': '/tools/buildbot/bin/python'} 12:46:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:46:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:46:02 INFO - Running setup.py (path:/tmp/pip-Kv0i0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:46:02 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)) 12:46:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:46:02 INFO - Running setup.py (path:/tmp/pip-icuUAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:46:02 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)) 12:46:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:46:02 INFO - Running setup.py (path:/tmp/pip-4QBxYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:46:02 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)) 12:46:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:46:02 INFO - Running setup.py (path:/tmp/pip-Oo9YEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:46:02 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)) 12:46:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:46:02 INFO - Running setup.py (path:/tmp/pip-1_D9z7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:46:02 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)) 12:46:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:46:02 INFO - Running setup.py (path:/tmp/pip-zsTujB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:46:02 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)) 12:46:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:46:02 INFO - Running setup.py (path:/tmp/pip-z7tSHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:46:02 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)) 12:46:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:46:02 INFO - Running setup.py (path:/tmp/pip-hAFZ25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:46:02 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)) 12:46:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:46:02 INFO - Running setup.py (path:/tmp/pip-uADJwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:46:02 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)) 12:46:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:46:02 INFO - Running setup.py (path:/tmp/pip-FxDOnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:46:02 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)) 12:46:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:46:02 INFO - Running setup.py (path:/tmp/pip-7hpEA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:46:02 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)) 12:46:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:46:02 INFO - Running setup.py (path:/tmp/pip-pek7uJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:46:02 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)) 12:46:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:46:02 INFO - Running setup.py (path:/tmp/pip-69AXk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:46:02 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)) 12:46:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:46:02 INFO - Running setup.py (path:/tmp/pip-FVSX74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:46:03 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)) 12:46:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:46:03 INFO - Running setup.py (path:/tmp/pip-W6Wm77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:46:03 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)) 12:46:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:46:03 INFO - Running setup.py (path:/tmp/pip-Whl5mm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:46:03 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)) 12:46:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:46:03 INFO - Running setup.py (path:/tmp/pip-VfxVxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:46:03 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)) 12:46:03 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)) 12:46:03 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)) 12:46:03 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)) 12:46:03 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)) 12:46:03 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)) 12:46:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:46:03 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 12:46:03 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 12:46:03 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 12:46:03 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 12:46:03 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 12:46:03 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 12:46:05 INFO - Downloading blessings-1.6.tar.gz 12:46:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:46:05 INFO - Installing collected packages: blessings 12:46:05 INFO - Running setup.py install for blessings 12:46:05 INFO - Successfully installed blessings 12:46:05 INFO - Cleaning up... 12:46:05 INFO - Return code: 0 12:46:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:46:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:46:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:46:05 INFO - Reading from file tmpfile_stdout 12:46:05 INFO - Current package versions: 12:46:05 INFO - argparse == 1.2.1 12:46:05 INFO - blessings == 1.6 12:46:05 INFO - blobuploader == 1.2.4 12:46:05 INFO - docopt == 0.6.1 12:46:05 INFO - functools32 == 3.2.3-2 12:46:05 INFO - jsonschema == 2.5.1 12:46:05 INFO - manifestparser == 1.1 12:46:05 INFO - mozInstall == 1.12 12:46:05 INFO - mozcrash == 0.17 12:46:05 INFO - mozdebug == 0.1 12:46:05 INFO - mozdevice == 0.48 12:46:05 INFO - mozfile == 1.2 12:46:05 INFO - mozhttpd == 0.7 12:46:05 INFO - mozinfo == 0.9 12:46:05 INFO - mozleak == 0.1 12:46:05 INFO - mozlog == 3.3 12:46:05 INFO - moznetwork == 0.27 12:46:05 INFO - mozprocess == 0.23 12:46:05 INFO - mozprofile == 0.28 12:46:05 INFO - mozrunner == 6.12 12:46:05 INFO - mozscreenshot == 0.1 12:46:05 INFO - mozsystemmonitor == 0.3 12:46:05 INFO - moztest == 0.7 12:46:05 INFO - mozversion == 1.4 12:46:05 INFO - psutil == 3.1.1 12:46:05 INFO - requests == 1.2.3 12:46:05 INFO - wsgiref == 0.1.2 12:46:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:46:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:46:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:46:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:46:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:46:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:46:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:46:05 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 0x21d8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x233b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2499180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24973b0>, '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 0x24982b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2498740>, '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': '745a4373a2a16df560f216e000000264-1469130332.78696-1346484126', '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 12:46:05 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 12:46:05 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 12:46:05 INFO - Using env: {'DISPLAY': ':0', 12:46:05 INFO - 'HOME': '/home/cltbld', 12:46:05 INFO - 'LANG': 'en_US.UTF-8', 12:46:05 INFO - 'LANGUAGE': 'en_US:en', 12:46:05 INFO - 'LOGNAME': 'cltbld', 12:46:05 INFO - 'MAIL': '/var/mail/cltbld', 12:46:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:46:05 INFO - 'MOZ_NO_REMOTE': '1', 12:46:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:46:05 INFO - 'NO_EM_RESTART': '1', 12:46:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:46:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:46:05 INFO - 'PWD': '/builds/slave/test', 12:46:05 INFO - 'SHELL': '/bin/bash', 12:46:05 INFO - 'SHLVL': '1', 12:46:05 INFO - 'TERM': 'linux', 12:46:05 INFO - 'TMOUT': '86400', 12:46:05 INFO - 'USER': 'cltbld', 12:46:05 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469130332.78696-1346484126', 12:46:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:46:05 INFO - '_': '/tools/buildbot/bin/python'} 12:46:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:46:05 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)) 12:46:05 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)) 12:46:05 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)) 12:46:05 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)) 12:46:05 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)) 12:46:05 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)) 12:46:05 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)) 12:46:05 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)) 12:46:05 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)) 12:46:05 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)) 12:46:05 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)) 12:46:05 INFO - Cleaning up... 12:46:05 INFO - Return code: 0 12:46:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:46:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:46:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:46:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:46:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:46:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:46:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:46:05 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 0x21d8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x233b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2499180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24973b0>, '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 0x24982b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2498740>, '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': '745a4373a2a16df560f216e000000264-1469130332.78696-1346484126', '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 12:46:05 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 12:46:05 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 12:46:05 INFO - Using env: {'DISPLAY': ':0', 12:46:05 INFO - 'HOME': '/home/cltbld', 12:46:05 INFO - 'LANG': 'en_US.UTF-8', 12:46:05 INFO - 'LANGUAGE': 'en_US:en', 12:46:05 INFO - 'LOGNAME': 'cltbld', 12:46:05 INFO - 'MAIL': '/var/mail/cltbld', 12:46:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:46:05 INFO - 'MOZ_NO_REMOTE': '1', 12:46:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:46:05 INFO - 'NO_EM_RESTART': '1', 12:46:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:46:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:46:05 INFO - 'PWD': '/builds/slave/test', 12:46:05 INFO - 'SHELL': '/bin/bash', 12:46:05 INFO - 'SHLVL': '1', 12:46:05 INFO - 'TERM': 'linux', 12:46:05 INFO - 'TMOUT': '86400', 12:46:05 INFO - 'USER': 'cltbld', 12:46:05 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469130332.78696-1346484126', 12:46:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:46:05 INFO - '_': '/tools/buildbot/bin/python'} 12:46:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:46:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:46:06 INFO - Cleaning up... 12:46:06 INFO - Return code: 0 12:46:06 INFO - Running post-action listener: _resource_record_post_action 12:46:06 INFO - Running post-action listener: _start_resource_monitoring 12:46:06 INFO - Starting resource monitoring. 12:46:06 INFO - [mozharness: 2016-07-21 19:46:06.128888Z] Finished create-virtualenv step (success) 12:46:06 INFO - [mozharness: 2016-07-21 19:46:06.129376Z] Running install step. 12:46:06 INFO - Running pre-action listener: _resource_record_pre_action 12:46:06 INFO - Running main action method: install 12:46:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:46:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:46:06 INFO - Reading from file tmpfile_stdout 12:46:06 INFO - Detecting whether we're running mozinstall >=1.0... 12:46:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:46:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:46:06 INFO - Reading from file tmpfile_stdout 12:46:06 INFO - Output received: 12:46:06 INFO - Usage: mozinstall [options] installer 12:46:06 INFO - Options: 12:46:06 INFO - -h, --help show this help message and exit 12:46:06 INFO - -d DEST, --destination=DEST 12:46:06 INFO - Directory to install application into. [default: 12:46:06 INFO - "/builds/slave/test"] 12:46:06 INFO - --app=APP Application being installed. [default: firefox] 12:46:06 INFO - mkdir: /builds/slave/test/build/application 12:46:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:46:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:46:24 INFO - Reading from file tmpfile_stdout 12:46:24 INFO - Output received: 12:46:24 INFO - /builds/slave/test/build/application/firefox/firefox 12:46:24 INFO - Running post-action listener: _resource_record_post_action 12:46:24 INFO - [mozharness: 2016-07-21 19:46:24.858050Z] Finished install step (success) 12:46:24 INFO - [mozharness: 2016-07-21 19:46:24.858325Z] Running run-tests step. 12:46:24 INFO - Running pre-action listener: _resource_record_pre_action 12:46:24 INFO - Running main action method: run_tests 12:46:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:46:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:46:24 INFO - Python 2.7.3 12:46:24 INFO - Return code: 0 12:46:24 INFO - grabbing minidump binary from tooltool 12:46:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:46:24 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 0x24973b0>, '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 0x24982b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2498740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:46:24 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 12:46:24 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 12:46:24 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 12:46:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:46:24 INFO - Return code: 0 12:46:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:46:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:46:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:46:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:46:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:46:24 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/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 12:46:24 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/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --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 12:46:24 INFO - Using env: {'DISPLAY': ':0', 12:46:24 INFO - 'HOME': '/home/cltbld', 12:46:24 INFO - 'LANG': 'en_US.UTF-8', 12:46:24 INFO - 'LANGUAGE': 'en_US:en', 12:46:24 INFO - 'LOGNAME': 'cltbld', 12:46:24 INFO - 'MAIL': '/var/mail/cltbld', 12:46:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:46:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:46:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:46:24 INFO - 'MOZ_NO_REMOTE': '1', 12:46:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:46:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:46:24 INFO - 'NO_EM_RESTART': '1', 12:46:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:46:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:46:24 INFO - 'PWD': '/builds/slave/test', 12:46:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:46:24 INFO - 'SHELL': '/bin/bash', 12:46:24 INFO - 'SHLVL': '1', 12:46:24 INFO - 'TERM': 'linux', 12:46:24 INFO - 'TMOUT': '86400', 12:46:24 INFO - 'USER': 'cltbld', 12:46:24 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469130332.78696-1346484126', 12:46:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:46:24 INFO - '_': '/tools/buildbot/bin/python'} 12:46:24 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/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 12:46:25 INFO - mozversion application_buildid: 20160721083037 12:46:25 INFO - mozversion application_changeset: f5154aaeaec4546dd04c66ac61a0d0ee69f4dfdf 12:46:25 INFO - mozversion application_display_name: Nightly 12:46:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:46:25 INFO - mozversion application_name: Firefox 12:46:25 INFO - mozversion application_remotingname: firefox 12:46:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:46:25 INFO - mozversion application_vendor: Mozilla 12:46:25 INFO - mozversion application_version: 50.0a1 12:46:25 INFO - mozversion platform_buildid: 20160721083037 12:46:25 INFO - mozversion platform_changeset: f5154aaeaec4546dd04c66ac61a0d0ee69f4dfdf 12:46:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:46:25 INFO - mozversion platform_version: 50.0a1 12:46:25 INFO - using testdate: 1469130385 12:46:25 INFO - actual date: 1469130385 12:46:25 INFO - starting webserver on 'localhost:41710' 12:46:25 INFO - SUITE-START | Running 2 tests 12:46:25 INFO - TEST-START | dromaeo_css 12:46:25 INFO - operating with platform_type : linux_ 12:46:25 INFO - Initialising browser for dromaeo_css test... 12:46:25 INFO - TEST-INFO | started process 21331 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpviT7QY/profile http://localhost:41710/getInfo.html) 12:46:28 INFO - PROCESS | 21331 | JavaScript error: , line 0: uncaught exception: undefined 12:46:30 INFO - PROCESS | 21331 | __metrics Screen width/height:1600/1200 12:46:30 INFO - PROCESS | 21331 | colorDepth:24 12:46:30 INFO - PROCESS | 21331 | Browser inner width/height: 1024/697 12:46:30 INFO - PROCESS | 21331 | __metrics 12:46:31 INFO - PROCESS | 21331 | 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" 12:46:31 INFO - PROCESS | 21331 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:46:32 INFO - TEST-INFO | 21331: exit 0 12:46:32 INFO - Browser initialized. 12:46:32 INFO - Running cycle 1/1 for dromaeo_css test... 12:46:32 INFO - TEST-INFO | started process 21416 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpviT7QY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:46:44 INFO - PROCESS | 21416 | RSS: Main: 158191616 12:46:44 INFO - PROCESS | 21416 | 12:47:35 INFO - PROCESS | 21416 | 1469130455481 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] 12:49:43 INFO - PROCESS | 21416 | Cycle 1(1): loaded http://localhost:41710/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41710/tests/dromaeo/cssquery-ext.html) 12:49:44 INFO - PROCESS | 21416 | RSS: Main: 247627776 12:49:44 INFO - PROCESS | 21416 | 12:52:47 INFO - PROCESS | 21416 | Cycle 1(1): loaded http://localhost:41710/tests/dromaeo/cssquery-ext.html (next: http://localhost:41710/tests/dromaeo/cssquery-jquery.html) 12:52:48 INFO - PROCESS | 21416 | RSS: Main: 251691008 12:52:48 INFO - PROCESS | 21416 | 12:55:49 INFO - PROCESS | 21416 | Cycle 1(1): loaded http://localhost:41710/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41710/tests/dromaeo/cssquery-mootools.html) 12:55:50 INFO - PROCESS | 21416 | RSS: Main: 233996288 12:55:50 INFO - PROCESS | 21416 | 12:58:52 INFO - PROCESS | 21416 | Cycle 1(1): loaded http://localhost:41710/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41710/tests/dromaeo/cssquery-prototype.html) 12:58:53 INFO - PROCESS | 21416 | RSS: Main: 233705472 12:58:53 INFO - PROCESS | 21416 | 13:01:55 INFO - PROCESS | 21416 | Cycle 1(1): loaded http://localhost:41710/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41710/tests/dromaeo/cssquery-yui.html) 13:01:56 INFO - PROCESS | 21416 | RSS: Main: 192937984 13:01:56 INFO - PROCESS | 21416 | 13:04:59 INFO - PROCESS | 21416 | Cycle 1(1): loaded http://localhost:41710/tests/dromaeo/cssquery-yui.html (next: http://localhost:41710/tests/dromaeo/cssquery-dojo.html) 13:04:59 INFO - PROCESS | 21416 | RSS: Main: 270782464 13:04:59 INFO - PROCESS | 21416 | 13:04:59 INFO - PROCESS | 21416 | __start_tp_report 13:04:59 INFO - PROCESS | 21416 | _x_x_mozilla_page_load 13:04:59 INFO - PROCESS | 21416 | _x_x_mozilla_page_load_details 13:04:59 INFO - PROCESS | 21416 | |i|pagename|runs| 13:04:59 INFO - PROCESS | 21416 | |0;dojo.html;3032.56027875958;3061.556074369215;3088.7220150186486;3094.644115926668;3099.473089574772;5117.8464646060675;5199.8440046798605;5228.843134705965;5301.310829592152;5315.495027972342;5239.449857764937;5267.762950667219;5316.9202461963105;5329.280547126137;5415.48552887475;4731.290306454025;4781.521847815226;4809.182438985381;4850;4898.363212782333;4775.952240477585;4894.77973491192;4912.606991440694;4940.925886111711;4941.135301322272;4877.097736918681;4878.731669758162;4887.755612219393;4887.975560122194;4924.975375123119;4289.1421715657;4649.907001859978;4694.741789201593;4785.760711964388;4829.154897892855;4760.976195119037;4767.404074490689;4768.809247630091;4834.734089625069;4886.291487734258;5284.735763211824;5324.893502129936;5353.063213937584;5384.138537833927;5384.461553844623;5470.425605311425;5626.971865140689;5674.602777805555;5696.743646535916;5723.856903577403;5766.682832444214;5779.537636989073;5784.595078344518;5791.855203619901;5792.333881603628;5422.864428389283;5427.620066595379;5430.348358197041;5436.320459942507;5436.429174936654;5625.662460252398;5699.458551437607;5755.482006619424;5762.279715035621;5873.559483038789;5556.583256255797;5598.1322894951345;5600.803971860965;5608.9719551402795;5617.354004289559;5640.012997725464;5662.5753068520025;5696.8860622787315;5699.088145896637;5704.486596206279;5468.863278418072;5525.336959564878;5571.554275657938;5577;5629.662220266797;5613.214150019001;5613.298337707786;5617.297837770278;5621.522170615462;5653.745581448845;4286.657067434598;4308.612224899712;4322.481302243751;4333.479982402069;4363.06194168249;3744.962550374516;3755.7934313613014;3812.3709587917683;3885.3783394657285;3890.183061557105;5385.461453854583;5386.084365657847;5390.218418329398;5408.161734931092;5434.782608695687;5692.772289108472;5706.457886500776;5711.514521265656;5715.5427565794635;5752.252207213036;5194.506521880416;5321.3348331458565;5365.3293338332705;5376.973115134399;5382.811601593926;4926.187179115406;4937.185364414831;4939.3084968104495;4963.379577552806;4986.351774269322;5836.358000619928;5876.941230587725;5879.823605291848;5891.617044892068;5895.29256489224;5460.781568737206;5597.496225339739;5660.518855897295;5713.971430142823;5766.711664416846;5838.2702162229725;5840.795572154954;5854;5865.648061116347;5876.941230587639;5533.114701647717;5534.418886017072;5537.224788529689;5549.472800083986;5551.666899986014;5495.230667706444;5563.554915606823;5605.04714198579;5612.074007788669;5646.096624540054;5502.284702988586;5521.889562208814;5539.224508568723;5576.860578485408;5607.327120745536;5467.480589344006;5506.284183056177;5516.282883225155;5519.668819870821;5522.723863806874;5373.194020896896;5517.531009864046;5518;5524.8342549721965;5580.358258800127;5571.60998730085;5685.886282274414;5687.146927960674;5692.203091567267;5694.174344720075;5510.228568000403;5515.22786809855;5516.117421212587;5519.641223320471;5524.198991146181 13:04:59 INFO - PROCESS | 21416 | |1;ext.html;590.0500194686555;627.1783963008457;659.8812213801517;666.3602941176471;678.5623272988919;31742.68257317426;35183;35267.118322041926;44293.7785311073;45684.314735279;46153;46601.30098048523;46607.30089048667;46730.53269467304;46794.53205467945;8884.289256859469;8963.865542016874;9011.684591039315;9014.774630634254;9025.729228123135;8140.226678465566;8306.377021723394;8307;8517.403781735282;8917;10665.573377064948;10928.289661172039;10951.288166269167;11275.097992160607;11286;10635.415052172128;10670.093042091432;10686.51910664022;10707.625233116803;10711.732206694856;8084.312833409167;10641.201909856793;10660.093892019187;10775.892241077567;11064;44094.33858492125;44481.555184448065;44481.777591112164;44519.33221001687;44613.55386446127;3600.8019558924248;3609.1338078861145;3641.107928557494;3647.723296846109;3795.1650636859845;34076.6592334076;34395;34490;34520;34582;3931.5085614298214;4045.312296909503;4063.476320357054;4081.8775436736946;4142.647874930634;358584.20707896556;358655;360210;360474;360869;60251.698741506014;60944.39055609476;61429.38570614237;61486;61493.38506614966;64873.351266487676;65187.67406162939;65196;65259;65318;16717.331306747594;17305.56736081608;17322.22050007753;17326.65346693059;17330.220140093727;13056.281904495345;13158.210507369397;13186.142900711424;13191.53829615978;13194.340282985811;16324.428644997368;17915.73126403105;18224.635507290044;18393.81606183948;18820.623587528175;6349.7931696009755;6378.681065946684;6535.803925882231;6595.73617055322;6696;947.8436058050482;1010.0656892374672;1054.630879192292;1073.9833024488357;1105.42517890698;31584;33233.3353332932;33669;33788.831055845054;34249.315013700085;1135.2904434728296;1168.7545615420856;1169.590643274847;1177.7997740384155;1193.8507686539183;17570.209340579706;17711.842446229653;17864.813015422387;17976.820231797778;17982.45396028552;512568;520309;520829;520842;520899;53387;61514;65141;66047.99999999904;66908.66545667338;1410.1539076553986;1412.3009110490373;1421.047897908404;1438.9496367627082;1441.8558144185497;31880.84059579687;33798.831005845794;34165;34392.65607343894;34949;46861.29708054314;47310.76344618255;47320.52679473299;47322.05355892794;47348.7632561835;509377;520099.5905388982;521264;725798;727097;28840.278993025342;28845;28870.71129288764;29127.7087229125;29229.123126306244;49646.50353496419;49824.50175498344;49864.33704045972;50564.49435505598;51435.74282128715;43088;43344.133117338104;43464.56535434605;44107;45574.772126139156;42257.366139508544;42667.78666106774;43100.78449607732;44116.55883441125;44381.33427998647;40414.79792601018;41743.58256417519;43265.7836710827;43406.34890476582;43490;36279.81860090682;38513.80743096267;38927.6107238924;39726;39808.80095599504;28570.42859142764;29011;29018.41963160767;29051.41897162087;29583.556246655888 13:04:59 INFO - PROCESS | 21416 | |2;jquery.html;372.0661140537251;387.39179488203513;394.09555071111805;398.8910827898442;414.5191577769788;14452.638684032905;17518.386856460027;19463.610727785435;19767.802321976775;19831.206751729933;18217.27130914765;18564.628707425843;18692.25230990762;18877.905610471964;18913.338033168842;4127.566605506408;5682.431756824316;5837.328707198662;5842;5843.298804143508;6070.301915279733;6338;6401.871962560769;6490.448311893495;6509.25143608484;6402.935970640304;6436.227652681685;6447.5809072410375;6456.192975878015;6498.317676643956;6322.0832979217985;6395.3284905084765;6433.1636887204595;6441.677916104223;6456.644884531349;5591.658002079513;5774.451427114417;5799.449052340021;5803.912941305884;5805.303363596396;22691.205807796814;22884.31347059591;23026.194083207007;23196.53606927852;23787.76212237873;2340.602097643388;2413.6379543068506;2595.480903819244;2604.2577865308294;2905.418916216744;14611.78082328766;14893.255337233095;15021.248937553079;15172.089674619558;15348.386064557517;1908.3225454963426;1942.873713208637;1951.1122439290089;1966.980330196694;1971.753530808649;83622.58188709078;85739.57130214371;86224.13775862286;86522;87165;9523.952380238194;9818.509074546244;9901.60393584263;10137.239707022003;10346.844797328045;13901.443942242398;13940.512082077079;13947.232902190477;13951.441942322397;13984.930075349557;7894.289513943772;8064.516129032277;8108.39187060961;8248.257656810916;8334.333253339719;8050.758477245692;8149.14433984435;8172.101068882418;8299.419040667095;8383.622736976851;6217.751289948442;6321.8619851343865;6323.30443651198;6335.556511044275;6528.249251336157;1783.4203883737837;1815.7639506864286;1825.078335440594;1852.2035524724497;1865.7108148237046;945.5792172483317;983.2527279267665;1021;1054.8206804843196;1078.417654466595;19544.31594894172;19915.302964396178;20044.59910801776;20118.497037573885;20429.387118386472;970.6020531582018;997.6907158780656;1003.2525768302661;1010.4240582867842;1033.834586466162;10465.790684186273;11122.764983372623;11141.832872506919;11275.436228188557;11320.603778867864;486598.56700716977;492108;496375;500701;508873;82221.17778822135;82335.58832205921;83301;83968;84702;1022.1465076660922;1031.5925209542188;1032.9896701033044;1038.5118994072773;1043.7077618266896;16837.579060523585;17272.568185795455;17704.521367008372;17760.644787104444;17845.37541186052;39665.80167099146;40372.192556148126;40573.39139912845;41557.168856623306;41860.79069604632;51690.483095168565;52966;53060.73469632627;53525.732371337894;55300.44699552953;7633.160352361125;8030.357571394391;8113.472624279403;8164.550949697824;8232.551871465539;12696.111272211227;12737.363131843556;12884.677883052998;12979.935100324437;13401.195928244337;11425.657230283105;11479.311241325548;11551.537938482703;11690.88309116898;11982.460789264329;6339.778107766206;11150.55042844425;11193.27243729155;11209.439528023404;11437.828432573684;11384.260023098472;11455;11562.710932226762;11628.709282268012;11869.881301186877;7938.801529961797;7965.880511792212;7973.681052757825;8050.27547520726;8344;11006.339619622848;11087.501062452371;11123.443827808416;11488.19582629208;11750.882491174978 13:04:59 INFO - PROCESS | 21416 | |3;mootools.html;1310.750957318109;1430.4349781836174;1511.0253886243374;1595.6569337592423;1793.327502186679;8493.617787199575;8729.388942774009;8843.336749743763;9072.455652660845;9196.816063678722;9019.54902254888;9126.315526335535;9150.633974641023;9181.449113053222;9182;2437.902483900642;2457.0785955266774;2463.8398504097177;2463.9014439422403;2464.0267094497663;2397.729203522127;2463.3841539615096;2465.9136930207446;2467.642191882176;2469.740677228892;2383.1063351243283;2393.3059412770276;2409.2170044735444;2421.806255499556;2433.4281443860677;2299.1837897546297;2309.7459279479244;2323.5236776460783;2353.49399879026;2360.527894421114;2311.976880231193;2337.906483740648;2362.799162071226;2362.988185059081;2366.3847399676206;8985.281177505849;9061.456312621263;9066.410683305565;9088.136627020422;9128.81742365149;5254.579633629301;5365.812196573141;5405.594580406446;5416;5417.377001644822;3155.3058327167987;3212.4699424594914;3234.9353012939846;3235.6440791512914;3250.1549597104686;1043.5669197283119;1051.201087173746;1059.793340298642;1067.765091679829;1071.3571856885806;12672;12711.491540338375;12751.74496510074;12772.425240864184;12799.296038717866;4353.608175264241;4558.840440584564;4575.679702420799;4629.86110416688;4645.140648979949;10059;10101.848472272923;10102.69691909244;10108.696739097839;10110.241731869992;5223.712695801692;5231.764570594256;5239.345081864767;5244.396894357198;5247.10799164143;4307.956920430818;4788.353572267769;4911.16510193268;4938.530839570235;4970.527799859007;3882.107115363482;3962.663173630274;4032.7580345179385;4067.349224124185;4068.105016896278;1189.1259923955886;1217.257472941505;1217.9817302740466;1221.6151912147645;1239.324568110382;918.6876462002951;999.6101520407047;1027.5889644142403;1031;1050.432766306186;6096.420840020191;6130.846728831815;6298.716557754912;6323.5573509854785;6326.905096423558;422.9809658565372;425.30038087346145;437.24138619495153;437.5602519467914;441.1794063042738;4112.835486580563;4119.258533463945;4169.332906734908;4201.579842015774;4280.101178752497;11011.724706882393;11437;11448.484818183202;11452;11461.197716159788;11339.319640821577;11366.772664546663;11374.090072794157;11380.658580242605;11417.657470275904;8347.999999999878;8426.831463370698;8512.319014478826;8521.44610600309;8523.318134549221;6098.298695650057;6099.939000610115;6220.7511699533325;6232.314445411092;6280.623162610258;10337.483125843528;10486.37081775096;10566.8414973777;10587.20595955291;10591.311564748266;10334.689959301233;10482.21383396233;10492.52783624754;10640.361578305326;10667.89332106669;6828.658567071528;7399.408047356091;7539.886901696588;7560.886586701314;7648.961755191189;8925.285977121684;8972.461652300883;8977.371583989057;8985.236254918143;8992;7897.328727058264;7985.480943738638;8135.877961830695;8187.959060204661;8228.876566851382;7816.452848300792;7928.405369597419;7929.801754956172;7974.84050319002;7980.401469889665;7000.8949865753075;7096.432285417258;7104.680289386886;7110.537815042006;7120.893186602101;5154.355705536808;5167.147420675697;5184;5193.792248310026;5413.589254498527;5391.433899440659;5519.454552725243;5531.308586426697;5570.749316280696;5596.300462442195 13:04:59 INFO - PROCESS | 21416 | |4;prototype.html;301.2784381406531;307.6569624868271;315.4180536909402;317.1579456542877;321.62851906048525;5366.517013468787;5401.756920938557;5422.701751403672;5425.2675888755;5438.428964958677;5137.717425541594;5263.947060646351;5271.262023316729;5283.603729720267;5394.730263486829;4014.4580481635044;4097.487814023255;4100.954256664561;4159.188958153161;4209.137126888981;4126.8761937141935;4138.0689344897455;4170.874873753777;4172.144710334374;4183.7489750614905;4045.797710114497;4091.529474110486;4102.425660407545;4106.322456794625;4116.75299482032;4098.446709694183;4117.3206420940505;4123.257813593567;4125.443065186221;4147.0461793787445;3621.022323972513;3623.8188090595363;3629.546306711661;3631.2011357501306;3661.5240018797654;5019.295431179647;5168.069747445458;5182.222666600002;5187.870303242411;5192.688438693691;4704.882377940545;4719.268513380432;4745.715257084586;4759.143354196243;4784.66507344486;5550.639208451478;5553.333599968029;5554.777808887639;5558.166275058733;5560.277163968699;3891.9610803891883;3987.302222111119;4024.93339265095;4036.6770658347555;4037.6366127048705;5718.656880587137;5749.712514374264;5766.711664416763;5797.710114494258;5799.478046975751;4065.4511640928686;4072.898177545585;4086.1214838809797;4088.6115818997146;4092.46797916269;4072.898177545526;4146.771927544014;4176.1230141670585;4179.895502612399;4189.49726032878;4704.835330763407;4712.363830882787;4741.525847415231;4757.5718185363485;4775.283707443911;5517;5548.667079975215;5555.2222688823595;5557.333120025542;5586.385497595261;1336.5923393365117;1419.6929988768252;1432.5272660022376;1436.1383170098065;1440.1503113163285;930.6463543853428;969.14230905649;987.3335498538457;991.1080027974737;999.5052449037773;5295.629305948547;5303.231031500411;5369.40936496985;5403.594730395236;5424.484673955968;5498.5876059295715;5707.200991861143;5740.770369185269;5757.740901659436;5759.395263497272;5316.229146773696;5322.121849894724;5328.413874473805;5370.650907690988;5382.192671099367;3030.196997795586;3030.848457577112;3039.2705750619693;3055.450018996602;3061.938761224763;5654.575906806924;5792.594518383673;5821;5885.529157667376;5900.557458190653;5751.913721294184;5755.3381361144;5756.683382414008;5773.971130144322;5776.277965254343;5831.2127862738835;5859.2382990211;5900.13843286006;5906.70466476683;5909.763609455659;5476.890462190813;5750.424957504383;5761.5390768739235;5768.567357448124;5787.160861674949;5694.601377903507;5728.541716662574;5729.598928074995;5736.282964629421;5807.8548036299435;5792.739326730391;5949.970250148895;5950.166976623363;6006.459418652343;6026.819195424145;4011.9799401002806;4027.711132437592;4049.392591111357;4064.5935406459116;4070.8575199867864;5881.38245484218;5882.382349853204;5886.470217680258;5896.6756828374855;5907.70461476933;5523;5611.7194140292;5629.6903670298525;5643.774249030157;5722.856928576819;5593.860153496195;5631.802886898939;5636.746346414503;5647.068233741551;5690.743916523849;5431;5459.508644222039;5586.190002449704;5714.114312281603;5719.199312096393;5508.91736623959;5630.747700919665;5638.577106716931;5644.576656750678;5653.265075540154;5487;5507.256520369859;5514.2004409359615;5523;5578.804741834017 13:04:59 INFO - PROCESS | 21416 | |5;yui.html;783.3185128937823;795.4869109424418;826.983460330793;852.6802449081595;881.6825942660641;15091;16286.185690715476;16296;16345.182740862969;16361.427350042752;15225.086494810319;15492.302846371913;15507.922460387683;15510.224488775544;15513.84486155138;668.0980676087291;794.2613369566301;804.5333706450259;815.975520734379;821.0434843407453;807.7495976247382;809.6073404398862;810.3112354498688;810.4853418079532;810.9635066422026;869.1395518436765;870.0125357718971;870.4037734152095;870.695256660167;870.8258348330328;713.1869668577825;862.8317478091775;872.5898827551041;876.2814492116468;887.3344991256557;616.9259688837324;629.238621268266;630.1492984470973;631.2803404119308;631.7915088020942;14640.267986600735;14732.926335368255;14805.185714785683;14816.851831481656;14822.481213157596;14544.70910581793;14597.12417254968;15223;15634.765478517831;15859.286332115082;12568.685782855411;12753.744925101539;12754.36228188587;12791.296478693668;13361.66595835102;3943.132510847609;3946.5264168299987;3979.5025621797276;4010.498687664042;4121.979390103031;76248.61875690587;76788.61605691991;76883.61558192174;78965.60517197434;80620.59689701514;11357.94321028406;11383.146264030065;11499.195056346143;11562.88437115635;12154.270743755404;23407.41481462977;23427.531449371258;23497.295081147593;23515.52968940646;23653.763462365157;8414.621342039623;8455.830883382298;8471.915280847235;8668.696595619123;8782.121787821166;4616.6306695464955;4744.24092145262;4744.976275118603;4891.290762839369;4921.680090794087;3709.8330575123646;3781.0736369589627;3809.1810260794064;3811.7903515306925;3813.046738315421;548.7859734703469;612.5620181570199;617.1267656266423;619.1548536247989;643.1638869469764;601.9939800602026;662.3277373465936;751.7368920877649;757.526545908807;760.7223363472293;9744.75638109053;10100.686910701561;10352.223583231287;10520.165961955396;10525.263231573716;682.931706829323;723.8588475247276;728.1735230513406;729.3946024799404;743.9516431431939;5057.115004874206;5068.619853510928;5118.206677964921;5180.248863914711;5190.247414125006;111104;111600;117546;119261.40369298271;120200.39899800446;100677;102960;106578;107555.46222268838;107766;86598.56700716456;87640;87764;88195.55902220577;88494;10477.214208934209;10495.685129446128;10534.631287904887;10700.892991070301;11017.11863050938;36339;38036.80981595185;44212.7789361064;53091.734541327045;53774.19338710001;49054.75472622614;50630.2405463911;63436;66321;78928.21071789438;13087.149335293176;13311.400986955416;13352.799708004193;13465.663358416117;13895.37470813836;14089.718205636034;14145.717085658434;14158.575242742734;14267.785983210053;14857.925710371812;13961;14499.752538356572;14515.274236287933;14666.011933990856;14926.328315225624;13508.594742157751;13547;14776.926115369355;14788.408463661333;14905.646229598253;13765.449382024606;14305.57083287503;14312.499062532761;14527.128372297697;14898.404063837324;11212.887871121184;11479.770404592029;11680.9881847478;11778.352190629597;12129.939350303192;10218.540165692413;10500.264981451224;10773.983368952291;11881.643550693492;12202.694932626755 13:04:59 INFO - PROCESS | 21416 | __end_tp_report 13:04:59 INFO - PROCESS | 21416 | __start_cc_report 13:04:59 INFO - PROCESS | 21416 | _x_x_mozilla_cycle_collect,958 13:04:59 INFO - PROCESS | 21416 | __end_cc_report 13:04:59 INFO - PROCESS | 21416 | __startTimestamp1469131499473__endTimestamp 13:04:59 INFO - PROCESS | 21416 | 13:04:59 INFO - PROCESS | 21416 | ------- Summary: start ------- 13:04:59 INFO - PROCESS | 21416 | Number of tests: 6 13:04:59 INFO - PROCESS | 21416 | 13:04:59 INFO - PROCESS | 21416 | [#0] dojo.html Cycles:165 Average:5268.04 Median:5506.28 stddev:602.68 (10.9%) stddev-sans-first:578.45 13:04:59 INFO - PROCESS | 21416 | Values: 3032.6 3061.6 3088.7 3094.6 3099.5 5117.8 5199.8 5228.8 5301.3 5315.5 5239.4 5267.8 5316.9 5329.3 5415.5 4731.3 4781.5 4809.2 4850.0 4898.4 4776.0 4894.8 4912.6 4940.9 4941.1 4877.1 4878.7 4887.8 4888.0 4925.0 4289.1 4649.9 4694.7 4785.8 4829.2 4761.0 4767.4 4768.8 4834.7 4886.3 5284.7 5324.9 5353.1 5384.1 5384.5 5470.4 5627.0 5674.6 5696.7 5723.9 5766.7 5779.5 5784.6 5791.9 5792.3 5422.9 5427.6 5430.3 5436.3 5436.4 5625.7 5699.5 5755.5 5762.3 5873.6 5556.6 5598.1 5600.8 5609.0 5617.4 5640.0 5662.6 5696.9 5699.1 5704.5 5468.9 5525.3 5571.6 5577.0 5629.7 5613.2 5613.3 5617.3 5621.5 5653.7 4286.7 4308.6 4322.5 4333.5 4363.1 3745.0 3755.8 3812.4 3885.4 3890.2 5385.5 5386.1 5390.2 5408.2 5434.8 5692.8 5706.5 5711.5 5715.5 5752.3 5194.5 5321.3 5365.3 5377.0 5382.8 4926.2 4937.2 4939.3 4963.4 4986.4 5836.4 5876.9 5879.8 5891.6 5895.3 5460.8 5597.5 5660.5 5714.0 5766.7 5838.3 5840.8 5854.0 5865.6 5876.9 5533.1 5534.4 5537.2 5549.5 5551.7 5495.2 5563.6 5605.0 5612.1 5646.1 5502.3 5521.9 5539.2 5576.9 5607.3 5467.5 5506.3 5516.3 5519.7 5522.7 5373.2 5517.5 5518.0 5524.8 5580.4 5571.6 5685.9 5687.1 5692.2 5694.2 5510.2 5515.2 5516.1 5519.6 5524.2 13:04:59 INFO - PROCESS | 21416 | 13:04:59 INFO - PROCESS | 21416 | [#1] ext.html Cycles:180 Average:65480.91 Median:39767.40 stddev:134974.23 (339.4%) stddev-sans-first:135264.93 13:04:59 INFO - PROCESS | 21416 | Values: 590.1 627.2 659.9 666.4 678.6 31742.7 35183.0 35267.1 44293.8 45684.3 46153.0 46601.3 46607.3 46730.5 46794.5 8884.3 8963.9 9011.7 9014.8 9025.7 8140.2 8306.4 8307.0 8517.4 8917.0 10665.6 10928.3 10951.3 11275.1 11286.0 10635.4 10670.1 10686.5 10707.6 10711.7 8084.3 10641.2 10660.1 10775.9 11064.0 44094.3 44481.6 44481.8 44519.3 44613.6 3600.8 3609.1 3641.1 3647.7 3795.2 34076.7 34395.0 34490.0 34520.0 34582.0 3931.5 4045.3 4063.5 4081.9 4142.6 358584.2 358655.0 360210.0 360474.0 360869.0 60251.7 60944.4 61429.4 61486.0 61493.4 64873.4 65187.7 65196.0 65259.0 65318.0 16717.3 17305.6 17322.2 17326.7 17330.2 13056.3 13158.2 13186.1 13191.5 13194.3 16324.4 17915.7 18224.6 18393.8 18820.6 6349.8 6378.7 6535.8 6595.7 6696.0 947.8 1010.1 1054.6 1074.0 1105.4 31584.0 33233.3 33669.0 33788.8 34249.3 1135.3 1168.8 1169.6 1177.8 1193.9 17570.2 17711.8 17864.8 17976.8 17982.5 512568.0 520309.0 520829.0 520842.0 520899.0 53387.0 61514.0 65141.0 66048.0 66908.7 1410.2 1412.3 1421.0 1438.9 1441.9 31880.8 33798.8 34165.0 34392.7 34949.0 46861.3 47310.8 47320.5 47322.1 47348.8 509377.0 520099.6 521264.0 725798.0 727097.0 28840.3 28845.0 28870.7 29127.7 29229.1 49646.5 49824.5 49864.3 50564.5 51435.7 43088.0 43344.1 43464.6 44107.0 45574.8 42257.4 42667.8 43100.8 44116.6 44381.3 40414.8 41743.6 43265.8 43406.3 43490.0 36279.8 38513.8 38927.6 39726.0 39808.8 28570.4 29011.0 29018.4 29051.4 29583.6 13:04:59 INFO - PROCESS | 21416 | 13:04:59 INFO - PROCESS | 21416 | [#2] jquery.html Cycles:180 Average:29009.97 Median:2754.84 stddev:81752.78 (2967.6%) stddev-sans-first:81953.84 13:04:59 INFO - PROCESS | 21416 | Values: 372.1 387.4 394.1 398.9 414.5 14452.6 17518.4 19463.6 19767.8 19831.2 18217.3 18564.6 18692.3 18877.9 18913.3 4127.6 5682.4 5837.3 5842.0 5843.3 6070.3 6338.0 6401.9 6490.4 6509.3 6402.9 6436.2 6447.6 6456.2 6498.3 6322.1 6395.3 6433.2 6441.7 6456.6 5591.7 5774.5 5799.4 5803.9 5805.3 22691.2 22884.3 23026.2 23196.5 23787.8 2340.6 2413.6 2595.5 2604.3 2905.4 14611.8 14893.3 15021.2 15172.1 15348.4 1908.3 1942.9 1951.1 1967.0 1971.8 83622.6 85739.6 86224.1 86522.0 87165.0 9524.0 9818.5 9901.6 10137.2 10346.8 13901.4 13940.5 13947.2 13951.4 13984.9 7894.3 8064.5 8108.4 8248.3 8334.3 8050.8 8149.1 8172.1 8299.4 8383.6 6217.8 6321.9 6323.3 6335.6 6528.2 1783.4 1815.8 1825.1 1852.2 1865.7 945.6 983.3 1021.0 1054.8 1078.4 19544.3 19915.3 20044.6 20118.5 20429.4 970.6 997.7 1003.3 1010.4 1033.8 10465.8 11122.8 11141.8 11275.4 11320.6 486598.6 492108.0 496375.0 500701.0 508873.0 82221.2 82335.6 83301.0 83968.0 84702.0 1022.1 1031.6 1033.0 1038.5 1043.7 16837.6 17272.6 17704.5 17760.6 17845.4 39665.8 40372.2 40573.4 41557.2 41860.8 51690.5 52966.0 53060.7 53525.7 55300.4 7633.2 8030.4 8113.5 8164.6 8232.6 12696.1 12737.4 12884.7 12979.9 13401.2 11425.7 11479.3 11551.5 11690.9 11982.5 6339.8 11150.6 11193.3 11209.4 11437.8 11384.3 11455.0 11562.7 11628.7 11869.9 7938.8 7965.9 7973.7 8050.3 8344.0 11006.3 11087.5 11123.4 11488.2 11750.9 13:04:59 INFO - PROCESS | 21416 | 13:04:59 INFO - PROCESS | 21416 | [#3] mootools.html Cycles:180 Average:5926.58 Median:4330.78 stddev:3437.54 (79.4%) stddev-sans-first:3429.68 13:04:59 INFO - PROCESS | 21416 | Values: 1310.8 1430.4 1511.0 1595.7 1793.3 8493.6 8729.4 8843.3 9072.5 9196.8 9019.5 9126.3 9150.6 9181.4 9182.0 2437.9 2457.1 2463.8 2463.9 2464.0 2397.7 2463.4 2465.9 2467.6 2469.7 2383.1 2393.3 2409.2 2421.8 2433.4 2299.2 2309.7 2323.5 2353.5 2360.5 2312.0 2337.9 2362.8 2363.0 2366.4 8985.3 9061.5 9066.4 9088.1 9128.8 5254.6 5365.8 5405.6 5416.0 5417.4 3155.3 3212.5 3234.9 3235.6 3250.2 1043.6 1051.2 1059.8 1067.8 1071.4 12672.0 12711.5 12751.7 12772.4 12799.3 4353.6 4558.8 4575.7 4629.9 4645.1 10059.0 10101.8 10102.7 10108.7 10110.2 5223.7 5231.8 5239.3 5244.4 5247.1 4308.0 4788.4 4911.2 4938.5 4970.5 3882.1 3962.7 4032.8 4067.3 4068.1 1189.1 1217.3 1218.0 1221.6 1239.3 918.7 999.6 1027.6 1031.0 1050.4 6096.4 6130.8 6298.7 6323.6 6326.9 423.0 425.3 437.2 437.6 441.2 4112.8 4119.3 4169.3 4201.6 4280.1 11011.7 11437.0 11448.5 11452.0 11461.2 11339.3 11366.8 11374.1 11380.7 11417.7 8348.0 8426.8 8512.3 8521.4 8523.3 6098.3 6099.9 6220.8 6232.3 6280.6 10337.5 10486.4 10566.8 10587.2 10591.3 10334.7 10482.2 10492.5 10640.4 10667.9 6828.7 7399.4 7539.9 7560.9 7649.0 8925.3 8972.5 8977.4 8985.2 8992.0 7897.3 7985.5 8135.9 8188.0 8228.9 7816.5 7928.4 7929.8 7974.8 7980.4 7000.9 7096.4 7104.7 7110.5 7120.9 5154.4 5167.1 5184.0 5193.8 5413.6 5391.4 5519.5 5531.3 5570.7 5596.3 13:04:59 INFO - PROCESS | 21416 | 13:04:59 INFO - PROCESS | 21416 | [#4] prototype.html Cycles:180 Average:4706.96 Median:5413.15 stddev:1390.02 (25.7%) stddev-sans-first:1354.02 13:04:59 INFO - PROCESS | 21416 | Values: 301.3 307.7 315.4 317.2 321.6 5366.5 5401.8 5422.7 5425.3 5438.4 5137.7 5263.9 5271.3 5283.6 5394.7 4014.5 4097.5 4101.0 4159.2 4209.1 4126.9 4138.1 4170.9 4172.1 4183.7 4045.8 4091.5 4102.4 4106.3 4116.8 4098.4 4117.3 4123.3 4125.4 4147.0 3621.0 3623.8 3629.5 3631.2 3661.5 5019.3 5168.1 5182.2 5187.9 5192.7 4704.9 4719.3 4745.7 4759.1 4784.7 5550.6 5553.3 5554.8 5558.2 5560.3 3892.0 3987.3 4024.9 4036.7 4037.6 5718.7 5749.7 5766.7 5797.7 5799.5 4065.5 4072.9 4086.1 4088.6 4092.5 4072.9 4146.8 4176.1 4179.9 4189.5 4704.8 4712.4 4741.5 4757.6 4775.3 5517.0 5548.7 5555.2 5557.3 5586.4 1336.6 1419.7 1432.5 1436.1 1440.2 930.6 969.1 987.3 991.1 999.5 5295.6 5303.2 5369.4 5403.6 5424.5 5498.6 5707.2 5740.8 5757.7 5759.4 5316.2 5322.1 5328.4 5370.7 5382.2 3030.2 3030.8 3039.3 3055.5 3061.9 5654.6 5792.6 5821.0 5885.5 5900.6 5751.9 5755.3 5756.7 5774.0 5776.3 5831.2 5859.2 5900.1 5906.7 5909.8 5476.9 5750.4 5761.5 5768.6 5787.2 5694.6 5728.5 5729.6 5736.3 5807.9 5792.7 5950.0 5950.2 6006.5 6026.8 4012.0 4027.7 4049.4 4064.6 4070.9 5881.4 5882.4 5886.5 5896.7 5907.7 5523.0 5611.7 5629.7 5643.8 5722.9 5593.9 5631.8 5636.7 5647.1 5690.7 5431.0 5459.5 5586.2 5714.1 5719.2 5508.9 5630.7 5638.6 5644.6 5653.3 5487.0 5507.3 5514.2 5523.0 5578.8 13:04:59 INFO - PROCESS | 21416 | 13:04:59 INFO - PROCESS | 21416 | [#5] yui.html Cycles:180 Average:20846.46 Median:3745.45 stddev:29939.50 (799.4%) stddev-sans-first:29985.59 13:04:59 INFO - PROCESS | 21416 | Values: 783.3 795.5 827.0 852.7 881.7 15091.0 16286.2 16296.0 16345.2 16361.4 15225.1 15492.3 15507.9 15510.2 15513.8 668.1 794.3 804.5 816.0 821.0 807.7 809.6 810.3 810.5 811.0 869.1 870.0 870.4 870.7 870.8 713.2 862.8 872.6 876.3 887.3 616.9 629.2 630.1 631.3 631.8 14640.3 14732.9 14805.2 14816.9 14822.5 14544.7 14597.1 15223.0 15634.8 15859.3 12568.7 12753.7 12754.4 12791.3 13361.7 3943.1 3946.5 3979.5 4010.5 4122.0 76248.6 76788.6 76883.6 78965.6 80620.6 11357.9 11383.1 11499.2 11562.9 12154.3 23407.4 23427.5 23497.3 23515.5 23653.8 8414.6 8455.8 8471.9 8668.7 8782.1 4616.6 4744.2 4745.0 4891.3 4921.7 3709.8 3781.1 3809.2 3811.8 3813.0 548.8 612.6 617.1 619.2 643.2 602.0 662.3 751.7 757.5 760.7 9744.8 10100.7 10352.2 10520.2 10525.3 682.9 723.9 728.2 729.4 744.0 5057.1 5068.6 5118.2 5180.2 5190.2 111104.0 111600.0 117546.0 119261.4 120200.4 100677.0 102960.0 106578.0 107555.5 107766.0 86598.6 87640.0 87764.0 88195.6 88494.0 10477.2 10495.7 10534.6 10700.9 11017.1 36339.0 38036.8 44212.8 53091.7 53774.2 49054.8 50630.2 63436.0 66321.0 78928.2 13087.1 13311.4 13352.8 13465.7 13895.4 14089.7 14145.7 14158.6 14267.8 14857.9 13961.0 14499.8 14515.3 14666.0 14926.3 13508.6 13547.0 14776.9 14788.4 14905.6 13765.4 14305.6 14312.5 14527.1 14898.4 11212.9 11479.8 11681.0 11778.4 12129.9 10218.5 10500.3 10774.0 11881.6 12202.7 13:04:59 INFO - PROCESS | 21416 | -------- Summary: end -------- 13:04:59 INFO - PROCESS | 21416 | 13:05:00 INFO - TEST-INFO | 21416: exit 0 13:05:00 INFO - TEST-OK | dromaeo_css | took 1115085ms 13:05:00 INFO - TEST-START | kraken 13:05:00 INFO - operating with platform_type : linux_ 13:05:00 INFO - Initialising browser for kraken test... 13:05:00 INFO - TEST-INFO | started process 21608 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZch7Ld/profile http://localhost:41710/getInfo.html) 13:05:03 INFO - PROCESS | 21608 | JavaScript error: , line 0: uncaught exception: undefined 13:05:04 INFO - PROCESS | 21608 | __metrics Screen width/height:1600/1200 13:05:04 INFO - PROCESS | 21608 | colorDepth:24 13:05:04 INFO - PROCESS | 21608 | Browser inner width/height: 1024/697 13:05:04 INFO - PROCESS | 21608 | __metrics 13:05:05 INFO - PROCESS | 21608 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:05:05 INFO - PROCESS | 21608 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:05:06 INFO - TEST-INFO | 21608: exit 0 13:05:06 INFO - Browser initialized. 13:05:06 INFO - Running cycle 1/1 for kraken test... 13:05:06 INFO - TEST-INFO | started process 21691 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZch7Ld/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:05:18 INFO - PROCESS | 21691 | RSS: Main: 157577216 13:05:18 INFO - PROCESS | 21691 | 13:05:21 INFO - PROCESS | 21691 | Cycle 1(1): loaded http://localhost:41710/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41710/tests/kraken/driver.html?testName=audio-beat-detection) 13:05:21 INFO - PROCESS | 21691 | RSS: Main: 214437888 13:05:21 INFO - PROCESS | 21691 | 13:05:24 INFO - PROCESS | 21691 | Cycle 1(1): loaded http://localhost:41710/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41710/tests/kraken/driver.html?testName=audio-dft) 13:05:25 INFO - PROCESS | 21691 | RSS: Main: 192393216 13:05:25 INFO - PROCESS | 21691 | 13:05:28 INFO - PROCESS | 21691 | Cycle 1(1): loaded http://localhost:41710/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41710/tests/kraken/driver.html?testName=audio-fft) 13:05:28 INFO - PROCESS | 21691 | RSS: Main: 270315520 13:05:28 INFO - PROCESS | 21691 | 13:05:31 INFO - PROCESS | 21691 | Cycle 1(1): loaded http://localhost:41710/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41710/tests/kraken/driver.html?testName=audio-oscillator) 13:05:31 INFO - PROCESS | 21691 | RSS: Main: 181022720 13:05:31 INFO - PROCESS | 21691 | 13:05:33 INFO - PROCESS | 21691 | Cycle 1(1): loaded http://localhost:41710/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41710/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:05:34 INFO - PROCESS | 21691 | RSS: Main: 185462784 13:05:34 INFO - PROCESS | 21691 | 13:05:37 INFO - PROCESS | 21691 | Cycle 1(1): loaded http://localhost:41710/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41710/tests/kraken/driver.html?testName=imaging-darkroom) 13:05:38 INFO - PROCESS | 21691 | RSS: Main: 222502912 13:05:38 INFO - PROCESS | 21691 | 13:05:41 INFO - PROCESS | 21691 | Cycle 1(1): loaded http://localhost:41710/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41710/tests/kraken/driver.html?testName=imaging-desaturate) 13:05:42 INFO - PROCESS | 21691 | RSS: Main: 221339648 13:05:42 INFO - PROCESS | 21691 | 13:05:44 INFO - PROCESS | 21691 | Cycle 1(1): loaded http://localhost:41710/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41710/tests/kraken/driver.html?testName=json-parse-financial) 13:05:45 INFO - PROCESS | 21691 | RSS: Main: 221114368 13:05:45 INFO - PROCESS | 21691 | 13:05:47 INFO - PROCESS | 21691 | Cycle 1(1): loaded http://localhost:41710/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41710/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:05:47 INFO - PROCESS | 21691 | RSS: Main: 185626624 13:05:47 INFO - PROCESS | 21691 | 13:05:49 INFO - PROCESS | 21691 | Cycle 1(1): loaded http://localhost:41710/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41710/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:05:50 INFO - PROCESS | 21691 | RSS: Main: 190681088 13:05:50 INFO - PROCESS | 21691 | 13:05:51 INFO - PROCESS | 21691 | Cycle 1(1): loaded http://localhost:41710/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41710/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:05:52 INFO - PROCESS | 21691 | RSS: Main: 195461120 13:05:52 INFO - PROCESS | 21691 | 13:05:55 INFO - PROCESS | 21691 | Cycle 1(1): loaded http://localhost:41710/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41710/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:05:55 INFO - PROCESS | 21691 | RSS: Main: 189112320 13:05:55 INFO - PROCESS | 21691 | 13:05:58 INFO - PROCESS | 21691 | Cycle 1(1): loaded http://localhost:41710/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41710/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:05:59 INFO - PROCESS | 21691 | RSS: Main: 194404352 13:05:59 INFO - PROCESS | 21691 | 13:06:00 INFO - PROCESS | 21691 | Cycle 1(1): loaded http://localhost:41710/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41710/tests/kraken/driver.html?testName=ai-astar) 13:06:00 INFO - PROCESS | 21691 | RSS: Main: 244248576 13:06:00 INFO - PROCESS | 21691 | 13:06:00 INFO - PROCESS | 21691 | __start_tp_report 13:06:00 INFO - PROCESS | 21691 | _x_x_mozilla_page_load 13:06:00 INFO - PROCESS | 21691 | _x_x_mozilla_page_load_details 13:06:00 INFO - PROCESS | 21691 | |i|pagename|runs| 13:06:00 INFO - PROCESS | 21691 | |0;ai-astar;101;111;111;110;111;111;112;109;111;112 13:06:00 INFO - PROCESS | 21691 | |1;audio-beat-detection;148;116;119;180;122;124;146;117;151;116 13:06:00 INFO - PROCESS | 21691 | |2;audio-dft;162;161;160;161;161;161;160;162;160;162 13:06:00 INFO - PROCESS | 21691 | |3;audio-fft;75;75;75;113;75;75;73;74;97;74 13:06:00 INFO - PROCESS | 21691 | |4;audio-oscillator;84;83;113;84;85;84;122;84;83;128 13:06:00 INFO - PROCESS | 21691 | |5;imaging-gaussian-blur;117;117;116;117;117;116;116;117;117;116 13:06:00 INFO - PROCESS | 21691 | |6;imaging-darkroom;145;146;145;145;146;145;146;147;146;146 13:06:00 INFO - PROCESS | 21691 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 13:06:00 INFO - PROCESS | 21691 | |8;json-parse-financial;54;52;52;54;54;53;54;53;53;58 13:06:00 INFO - PROCESS | 21691 | |9;json-stringify-tinderbox;62;62;62;62;63;63;62;62;64;63 13:06:00 INFO - PROCESS | 21691 | |10;stanford-crypto-aes;75;75;76;75;84;77;75;76;75;79 13:06:00 INFO - PROCESS | 21691 | |11;stanford-crypto-ccm;130;121;120;128;119;125;120;119;174;120 13:06:00 INFO - PROCESS | 21691 | |12;stanford-crypto-pbkdf2;153;153;156;156;158;154;158;156;152;156 13:06:00 INFO - PROCESS | 21691 | |13;stanford-crypto-sha256-iterative;63;63;64;63;66;62;63;62;64;62 13:06:00 INFO - PROCESS | 21691 | __end_tp_report 13:06:00 INFO - PROCESS | 21691 | __start_cc_report 13:06:00 INFO - PROCESS | 21691 | _x_x_mozilla_cycle_collect,1708 13:06:00 INFO - PROCESS | 21691 | __end_cc_report 13:06:00 INFO - PROCESS | 21691 | __startTimestamp1469131560919__endTimestamp 13:06:00 INFO - PROCESS | 21691 | 13:06:00 INFO - PROCESS | 21691 | ------- Summary: start ------- 13:06:00 INFO - PROCESS | 21691 | Number of tests: 14 13:06:00 INFO - PROCESS | 21691 | 13:06:00 INFO - PROCESS | 21691 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:3.25 (2.9%) stddev-sans-first:0.93 13:06:00 INFO - PROCESS | 21691 | Values: 101.0 111.0 111.0 110.0 111.0 111.0 112.0 109.0 111.0 112.0 13:06:00 INFO - PROCESS | 21691 | 13:06:00 INFO - PROCESS | 21691 | [#1] audio-beat-detection Cycles:10 Average:133.90 Median:135.00 stddev:21.48 (15.9%) stddev-sans-first:22.16 13:06:00 INFO - PROCESS | 21691 | Values: 148.0 116.0 119.0 180.0 122.0 124.0 146.0 117.0 151.0 116.0 13:06:00 INFO - PROCESS | 21691 | 13:06:00 INFO - PROCESS | 21691 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.78 13:06:00 INFO - PROCESS | 21691 | Values: 162.0 161.0 160.0 161.0 161.0 161.0 160.0 162.0 160.0 162.0 13:06:00 INFO - PROCESS | 21691 | 13:06:00 INFO - PROCESS | 21691 | [#3] audio-fft Cycles:10 Average:80.60 Median:75.00 stddev:13.42 (17.9%) stddev-sans-first:14.08 13:06:00 INFO - PROCESS | 21691 | Values: 75.0 75.0 75.0 113.0 75.0 75.0 73.0 74.0 97.0 74.0 13:06:00 INFO - PROCESS | 21691 | 13:06:00 INFO - PROCESS | 21691 | [#4] audio-oscillator Cycles:10 Average:95.00 Median:84.00 stddev:18.30 (21.8%) stddev-sans-first:18.97 13:06:00 INFO - PROCESS | 21691 | Values: 84.0 83.0 113.0 84.0 85.0 84.0 122.0 84.0 83.0 128.0 13:06:00 INFO - PROCESS | 21691 | 13:06:00 INFO - PROCESS | 21691 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 13:06:00 INFO - PROCESS | 21691 | Values: 117.0 117.0 116.0 117.0 117.0 116.0 116.0 117.0 117.0 116.0 13:06:00 INFO - PROCESS | 21691 | 13:06:00 INFO - PROCESS | 21691 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 13:06:00 INFO - PROCESS | 21691 | Values: 145.0 146.0 145.0 145.0 146.0 145.0 146.0 147.0 146.0 146.0 13:06:00 INFO - PROCESS | 21691 | 13:06:00 INFO - PROCESS | 21691 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 13:06:00 INFO - PROCESS | 21691 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 13:06:00 INFO - PROCESS | 21691 | 13:06:00 INFO - PROCESS | 21691 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.00 stddev:1.70 (3.2%) stddev-sans-first:1.80 13:06:00 INFO - PROCESS | 21691 | Values: 54.0 52.0 52.0 54.0 54.0 53.0 54.0 53.0 53.0 58.0 13:06:00 INFO - PROCESS | 21691 | 13:06:00 INFO - PROCESS | 21691 | [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:62.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 13:06:00 INFO - PROCESS | 21691 | Values: 62.0 62.0 62.0 62.0 63.0 63.0 62.0 62.0 64.0 63.0 13:06:00 INFO - PROCESS | 21691 | 13:06:00 INFO - PROCESS | 21691 | [#10] stanford-crypto-aes Cycles:10 Average:76.70 Median:76.00 stddev:2.87 (3.8%) stddev-sans-first:2.98 13:06:00 INFO - PROCESS | 21691 | Values: 75.0 75.0 76.0 75.0 84.0 77.0 75.0 76.0 75.0 79.0 13:06:00 INFO - PROCESS | 21691 | 13:06:00 INFO - PROCESS | 21691 | [#11] stanford-crypto-ccm Cycles:10 Average:127.60 Median:123.00 stddev:16.77 (13.6%) stddev-sans-first:17.76 13:06:00 INFO - PROCESS | 21691 | Values: 130.0 121.0 120.0 128.0 119.0 125.0 120.0 119.0 174.0 120.0 13:06:00 INFO - PROCESS | 21691 | 13:06:00 INFO - PROCESS | 21691 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.20 Median:156.00 stddev:2.10 (1.3%) stddev-sans-first:2.07 13:06:00 INFO - PROCESS | 21691 | Values: 153.0 153.0 156.0 156.0 158.0 154.0 158.0 156.0 152.0 156.0 13:06:00 INFO - PROCESS | 21691 | 13:06:00 INFO - PROCESS | 21691 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.00 stddev:1.23 (2.0%) stddev-sans-first:1.30 13:06:00 INFO - PROCESS | 21691 | Values: 63.0 63.0 64.0 63.0 66.0 62.0 63.0 62.0 64.0 62.0 13:06:00 INFO - PROCESS | 21691 | -------- Summary: end -------- 13:06:00 INFO - PROCESS | 21691 | 13:06:01 INFO - TEST-INFO | 21691: exit 0 13:06:02 INFO - TEST-OK | kraken | took 61809ms 13:06:02 INFO - SUITE-END | took 1176s 13:06:02 INFO - Completed test suite (00:19:36) 13:06:02 INFO - javascript benchmark 13:06:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3032.56027875958, 3061.556074369215, 3088.7220150186486, 3094.644115926668, 3099.473089574772, 5117.8464646060675, 5199.8440046798605, 5228.843134705965, 5301.310829592152, 5315.495027972342, 5239.449857764937, 5267.762950667219, 5316.9202461963105, 5329.280547126137, 5415.48552887475, 4731.290306454025, 4781.521847815226, 4809.182438985381, 4850.0, 4898.363212782333, 4775.952240477585, 4894.77973491192, 4912.606991440694, 4940.925886111711, 4941.135301322272, 4877.097736918681, 4878.731669758162, 4887.755612219393, 4887.975560122194, 4924.975375123119, 4289.1421715657, 4649.907001859978, 4694.741789201593, 4785.760711964388, 4829.154897892855, 4760.976195119037, 4767.404074490689, 4768.809247630091, 4834.734089625069, 4886.291487734258, 5284.735763211824, 5324.893502129936, 5353.063213937584, 5384.138537833927, 5384.461553844623, 5470.425605311425, 5626.971865140689, 5674.602777805555, 5696.743646535916, 5723.856903577403, 5766.682832444214, 5779.537636989073, 5784.595078344518, 5791.855203619901, 5792.333881603628, 5422.864428389283, 5427.620066595379, 5430.348358197041, 5436.320459942507, 5436.429174936654, 5625.662460252398, 5699.458551437607, 5755.482006619424, 5762.279715035621, 5873.559483038789, 5556.583256255797, 5598.1322894951345, 5600.803971860965, 5608.9719551402795, 5617.354004289559, 5640.012997725464, 5662.5753068520025, 5696.8860622787315, 5699.088145896637, 5704.486596206279, 5468.863278418072, 5525.336959564878, 5571.554275657938, 5577.0, 5629.662220266797, 5613.214150019001, 5613.298337707786, 5617.297837770278, 5621.522170615462, 5653.745581448845, 4286.657067434598, 4308.612224899712, 4322.481302243751, 4333.479982402069, 4363.06194168249, 3744.962550374516, 3755.7934313613014, 3812.3709587917683, 3885.3783394657285, 3890.183061557105, 5385.461453854583, 5386.084365657847, 5390.218418329398, 5408.161734931092, 5434.782608695687, 5692.772289108472, 5706.457886500776, 5711.514521265656, 5715.5427565794635, 5752.252207213036, 5194.506521880416, 5321.3348331458565, 5365.3293338332705, 5376.973115134399, 5382.811601593926, 4926.187179115406, 4937.185364414831, 4939.3084968104495, 4963.379577552806, 4986.351774269322, 5836.358000619928, 5876.941230587725, 5879.823605291848, 5891.617044892068, 5895.29256489224, 5460.781568737206, 5597.496225339739, 5660.518855897295, 5713.971430142823, 5766.711664416846, 5838.2702162229725, 5840.795572154954, 5854.0, 5865.648061116347, 5876.941230587639, 5533.114701647717, 5534.418886017072, 5537.224788529689, 5549.472800083986, 5551.666899986014, 5495.230667706444, 5563.554915606823, 5605.04714198579, 5612.074007788669, 5646.096624540054, 5502.284702988586, 5521.889562208814, 5539.224508568723, 5576.860578485408, 5607.327120745536, 5467.480589344006, 5506.284183056177, 5516.282883225155, 5519.668819870821, 5522.723863806874, 5373.194020896896, 5517.531009864046, 5518.0, 5524.8342549721965, 5580.358258800127, 5571.60998730085, 5685.886282274414, 5687.146927960674, 5692.203091567267, 5694.174344720075, 5510.228568000403, 5515.22786809855, 5516.117421212587, 5519.641223320471, 5524.198991146181], "value": 5227.047197640631, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.0500194686555, 627.1783963008457, 659.8812213801517, 666.3602941176471, 678.5623272988919, 31742.68257317426, 35183.0, 35267.118322041926, 44293.7785311073, 45684.314735279, 46153.0, 46601.30098048523, 46607.30089048667, 46730.53269467304, 46794.53205467945, 8884.289256859469, 8963.865542016874, 9011.684591039315, 9014.774630634254, 9025.729228123135, 8140.226678465566, 8306.377021723394, 8307.0, 8517.403781735282, 8917.0, 10665.573377064948, 10928.289661172039, 10951.288166269167, 11275.097992160607, 11286.0, 10635.415052172128, 10670.093042091432, 10686.51910664022, 10707.625233116803, 10711.732206694856, 8084.312833409167, 10641.201909856793, 10660.093892019187, 10775.892241077567, 11064.0, 44094.33858492125, 44481.555184448065, 44481.777591112164, 44519.33221001687, 44613.55386446127, 3600.8019558924248, 3609.1338078861145, 3641.107928557494, 3647.723296846109, 3795.1650636859845, 34076.6592334076, 34395.0, 34490.0, 34520.0, 34582.0, 3931.5085614298214, 4045.312296909503, 4063.476320357054, 4081.8775436736946, 4142.647874930634, 358584.20707896556, 358655.0, 360210.0, 360474.0, 360869.0, 60251.698741506014, 60944.39055609476, 61429.38570614237, 61486.0, 61493.38506614966, 64873.351266487676, 65187.67406162939, 65196.0, 65259.0, 65318.0, 16717.331306747594, 17305.56736081608, 17322.22050007753, 17326.65346693059, 17330.220140093727, 13056.281904495345, 13158.210507369397, 13186.142900711424, 13191.53829615978, 13194.340282985811, 16324.428644997368, 17915.73126403105, 18224.635507290044, 18393.81606183948, 18820.623587528175, 6349.7931696009755, 6378.681065946684, 6535.803925882231, 6595.73617055322, 6696.0, 947.8436058050482, 1010.0656892374672, 1054.630879192292, 1073.9833024488357, 1105.42517890698, 31584.0, 33233.3353332932, 33669.0, 33788.831055845054, 34249.315013700085, 1135.2904434728296, 1168.7545615420856, 1169.590643274847, 1177.7997740384155, 1193.8507686539183, 17570.209340579706, 17711.842446229653, 17864.813015422387, 17976.820231797778, 17982.45396028552, 512568.0, 520309.0, 520829.0, 520842.0, 520899.0, 53387.0, 61514.0, 65141.0, 66047.99999999904, 66908.66545667338, 1410.1539076553986, 1412.3009110490373, 1421.047897908404, 1438.9496367627082, 1441.8558144185497, 31880.84059579687, 33798.831005845794, 34165.0, 34392.65607343894, 34949.0, 46861.29708054314, 47310.76344618255, 47320.52679473299, 47322.05355892794, 47348.7632561835, 509377.0, 520099.5905388982, 521264.0, 725798.0, 727097.0, 28840.278993025342, 28845.0, 28870.71129288764, 29127.7087229125, 29229.123126306244, 49646.50353496419, 49824.50175498344, 49864.33704045972, 50564.49435505598, 51435.74282128715, 43088.0, 43344.133117338104, 43464.56535434605, 44107.0, 45574.772126139156, 42257.366139508544, 42667.78666106774, 43100.78449607732, 44116.55883441125, 44381.33427998647, 40414.79792601018, 41743.58256417519, 43265.7836710827, 43406.34890476582, 43490.0, 36279.81860090682, 38513.80743096267, 38927.6107238924, 39726.0, 39808.80095599504, 28570.42859142764, 29011.0, 29018.41963160767, 29051.41897162087, 29583.556246655888], "value": 20980.129828128684, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.0661140537251, 387.39179488203513, 394.09555071111805, 398.8910827898442, 414.5191577769788, 14452.638684032905, 17518.386856460027, 19463.610727785435, 19767.802321976775, 19831.206751729933, 18217.27130914765, 18564.628707425843, 18692.25230990762, 18877.905610471964, 18913.338033168842, 4127.566605506408, 5682.431756824316, 5837.328707198662, 5842.0, 5843.298804143508, 6070.301915279733, 6338.0, 6401.871962560769, 6490.448311893495, 6509.25143608484, 6402.935970640304, 6436.227652681685, 6447.5809072410375, 6456.192975878015, 6498.317676643956, 6322.0832979217985, 6395.3284905084765, 6433.1636887204595, 6441.677916104223, 6456.644884531349, 5591.658002079513, 5774.451427114417, 5799.449052340021, 5803.912941305884, 5805.303363596396, 22691.205807796814, 22884.31347059591, 23026.194083207007, 23196.53606927852, 23787.76212237873, 2340.602097643388, 2413.6379543068506, 2595.480903819244, 2604.2577865308294, 2905.418916216744, 14611.78082328766, 14893.255337233095, 15021.248937553079, 15172.089674619558, 15348.386064557517, 1908.3225454963426, 1942.873713208637, 1951.1122439290089, 1966.980330196694, 1971.753530808649, 83622.58188709078, 85739.57130214371, 86224.13775862286, 86522.0, 87165.0, 9523.952380238194, 9818.509074546244, 9901.60393584263, 10137.239707022003, 10346.844797328045, 13901.443942242398, 13940.512082077079, 13947.232902190477, 13951.441942322397, 13984.930075349557, 7894.289513943772, 8064.516129032277, 8108.39187060961, 8248.257656810916, 8334.333253339719, 8050.758477245692, 8149.14433984435, 8172.101068882418, 8299.419040667095, 8383.622736976851, 6217.751289948442, 6321.8619851343865, 6323.30443651198, 6335.556511044275, 6528.249251336157, 1783.4203883737837, 1815.7639506864286, 1825.078335440594, 1852.2035524724497, 1865.7108148237046, 945.5792172483317, 983.2527279267665, 1021.0, 1054.8206804843196, 1078.417654466595, 19544.31594894172, 19915.302964396178, 20044.59910801776, 20118.497037573885, 20429.387118386472, 970.6020531582018, 997.6907158780656, 1003.2525768302661, 1010.4240582867842, 1033.834586466162, 10465.790684186273, 11122.764983372623, 11141.832872506919, 11275.436228188557, 11320.603778867864, 486598.56700716977, 492108.0, 496375.0, 500701.0, 508873.0, 82221.17778822135, 82335.58832205921, 83301.0, 83968.0, 84702.0, 1022.1465076660922, 1031.5925209542188, 1032.9896701033044, 1038.5118994072773, 1043.7077618266896, 16837.579060523585, 17272.568185795455, 17704.521367008372, 17760.644787104444, 17845.37541186052, 39665.80167099146, 40372.192556148126, 40573.39139912845, 41557.168856623306, 41860.79069604632, 51690.483095168565, 52966.0, 53060.73469632627, 53525.732371337894, 55300.44699552953, 7633.160352361125, 8030.357571394391, 8113.472624279403, 8164.550949697824, 8232.551871465539, 12696.111272211227, 12737.363131843556, 12884.677883052998, 12979.935100324437, 13401.195928244337, 11425.657230283105, 11479.311241325548, 11551.537938482703, 11690.88309116898, 11982.460789264329, 6339.778107766206, 11150.55042844425, 11193.27243729155, 11209.439528023404, 11437.828432573684, 11384.260023098472, 11455.0, 11562.710932226762, 11628.709282268012, 11869.881301186877, 7938.801529961797, 7965.880511792212, 7973.681052757825, 8050.27547520726, 8344.0, 11006.339619622848, 11087.501062452371, 11123.443827808416, 11488.19582629208, 11750.882491174978], "value": 9339.986453359794, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1310.750957318109, 1430.4349781836174, 1511.0253886243374, 1595.6569337592423, 1793.327502186679, 8493.617787199575, 8729.388942774009, 8843.336749743763, 9072.455652660845, 9196.816063678722, 9019.54902254888, 9126.315526335535, 9150.633974641023, 9181.449113053222, 9182.0, 2437.902483900642, 2457.0785955266774, 2463.8398504097177, 2463.9014439422403, 2464.0267094497663, 2397.729203522127, 2463.3841539615096, 2465.9136930207446, 2467.642191882176, 2469.740677228892, 2383.1063351243283, 2393.3059412770276, 2409.2170044735444, 2421.806255499556, 2433.4281443860677, 2299.1837897546297, 2309.7459279479244, 2323.5236776460783, 2353.49399879026, 2360.527894421114, 2311.976880231193, 2337.906483740648, 2362.799162071226, 2362.988185059081, 2366.3847399676206, 8985.281177505849, 9061.456312621263, 9066.410683305565, 9088.136627020422, 9128.81742365149, 5254.579633629301, 5365.812196573141, 5405.594580406446, 5416.0, 5417.377001644822, 3155.3058327167987, 3212.4699424594914, 3234.9353012939846, 3235.6440791512914, 3250.1549597104686, 1043.5669197283119, 1051.201087173746, 1059.793340298642, 1067.765091679829, 1071.3571856885806, 12672.0, 12711.491540338375, 12751.74496510074, 12772.425240864184, 12799.296038717866, 4353.608175264241, 4558.840440584564, 4575.679702420799, 4629.86110416688, 4645.140648979949, 10059.0, 10101.848472272923, 10102.69691909244, 10108.696739097839, 10110.241731869992, 5223.712695801692, 5231.764570594256, 5239.345081864767, 5244.396894357198, 5247.10799164143, 4307.956920430818, 4788.353572267769, 4911.16510193268, 4938.530839570235, 4970.527799859007, 3882.107115363482, 3962.663173630274, 4032.7580345179385, 4067.349224124185, 4068.105016896278, 1189.1259923955886, 1217.257472941505, 1217.9817302740466, 1221.6151912147645, 1239.324568110382, 918.6876462002951, 999.6101520407047, 1027.5889644142403, 1031.0, 1050.432766306186, 6096.420840020191, 6130.846728831815, 6298.716557754912, 6323.5573509854785, 6326.905096423558, 422.9809658565372, 425.30038087346145, 437.24138619495153, 437.5602519467914, 441.1794063042738, 4112.835486580563, 4119.258533463945, 4169.332906734908, 4201.579842015774, 4280.101178752497, 11011.724706882393, 11437.0, 11448.484818183202, 11452.0, 11461.197716159788, 11339.319640821577, 11366.772664546663, 11374.090072794157, 11380.658580242605, 11417.657470275904, 8347.999999999878, 8426.831463370698, 8512.319014478826, 8521.44610600309, 8523.318134549221, 6098.298695650057, 6099.939000610115, 6220.7511699533325, 6232.314445411092, 6280.623162610258, 10337.483125843528, 10486.37081775096, 10566.8414973777, 10587.20595955291, 10591.311564748266, 10334.689959301233, 10482.21383396233, 10492.52783624754, 10640.361578305326, 10667.89332106669, 6828.658567071528, 7399.408047356091, 7539.886901696588, 7560.886586701314, 7648.961755191189, 8925.285977121684, 8972.461652300883, 8977.371583989057, 8985.236254918143, 8992.0, 7897.328727058264, 7985.480943738638, 8135.877961830695, 8187.959060204661, 8228.876566851382, 7816.452848300792, 7928.405369597419, 7929.801754956172, 7974.84050319002, 7980.401469889665, 7000.8949865753075, 7096.432285417258, 7104.680289386886, 7110.537815042006, 7120.893186602101, 5154.355705536808, 5167.147420675697, 5184.0, 5193.792248310026, 5413.589254498527, 5391.433899440659, 5519.454552725243, 5531.308586426697, 5570.749316280696, 5596.300462442195], "value": 4622.634866638857, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.2784381406531, 307.6569624868271, 315.4180536909402, 317.1579456542877, 321.62851906048525, 5366.517013468787, 5401.756920938557, 5422.701751403672, 5425.2675888755, 5438.428964958677, 5137.717425541594, 5263.947060646351, 5271.262023316729, 5283.603729720267, 5394.730263486829, 4014.4580481635044, 4097.487814023255, 4100.954256664561, 4159.188958153161, 4209.137126888981, 4126.8761937141935, 4138.0689344897455, 4170.874873753777, 4172.144710334374, 4183.7489750614905, 4045.797710114497, 4091.529474110486, 4102.425660407545, 4106.322456794625, 4116.75299482032, 4098.446709694183, 4117.3206420940505, 4123.257813593567, 4125.443065186221, 4147.0461793787445, 3621.022323972513, 3623.8188090595363, 3629.546306711661, 3631.2011357501306, 3661.5240018797654, 5019.295431179647, 5168.069747445458, 5182.222666600002, 5187.870303242411, 5192.688438693691, 4704.882377940545, 4719.268513380432, 4745.715257084586, 4759.143354196243, 4784.66507344486, 5550.639208451478, 5553.333599968029, 5554.777808887639, 5558.166275058733, 5560.277163968699, 3891.9610803891883, 3987.302222111119, 4024.93339265095, 4036.6770658347555, 4037.6366127048705, 5718.656880587137, 5749.712514374264, 5766.711664416763, 5797.710114494258, 5799.478046975751, 4065.4511640928686, 4072.898177545585, 4086.1214838809797, 4088.6115818997146, 4092.46797916269, 4072.898177545526, 4146.771927544014, 4176.1230141670585, 4179.895502612399, 4189.49726032878, 4704.835330763407, 4712.363830882787, 4741.525847415231, 4757.5718185363485, 4775.283707443911, 5517.0, 5548.667079975215, 5555.2222688823595, 5557.333120025542, 5586.385497595261, 1336.5923393365117, 1419.6929988768252, 1432.5272660022376, 1436.1383170098065, 1440.1503113163285, 930.6463543853428, 969.14230905649, 987.3335498538457, 991.1080027974737, 999.5052449037773, 5295.629305948547, 5303.231031500411, 5369.40936496985, 5403.594730395236, 5424.484673955968, 5498.5876059295715, 5707.200991861143, 5740.770369185269, 5757.740901659436, 5759.395263497272, 5316.229146773696, 5322.121849894724, 5328.413874473805, 5370.650907690988, 5382.192671099367, 3030.196997795586, 3030.848457577112, 3039.2705750619693, 3055.450018996602, 3061.938761224763, 5654.575906806924, 5792.594518383673, 5821.0, 5885.529157667376, 5900.557458190653, 5751.913721294184, 5755.3381361144, 5756.683382414008, 5773.971130144322, 5776.277965254343, 5831.2127862738835, 5859.2382990211, 5900.13843286006, 5906.70466476683, 5909.763609455659, 5476.890462190813, 5750.424957504383, 5761.5390768739235, 5768.567357448124, 5787.160861674949, 5694.601377903507, 5728.541716662574, 5729.598928074995, 5736.282964629421, 5807.8548036299435, 5792.739326730391, 5949.970250148895, 5950.166976623363, 6006.459418652343, 6026.819195424145, 4011.9799401002806, 4027.711132437592, 4049.392591111357, 4064.5935406459116, 4070.8575199867864, 5881.38245484218, 5882.382349853204, 5886.470217680258, 5896.6756828374855, 5907.70461476933, 5523.0, 5611.7194140292, 5629.6903670298525, 5643.774249030157, 5722.856928576819, 5593.860153496195, 5631.802886898939, 5636.746346414503, 5647.068233741551, 5690.743916523849, 5431.0, 5459.508644222039, 5586.190002449704, 5714.114312281603, 5719.199312096393, 5508.91736623959, 5630.747700919665, 5638.577106716931, 5644.576656750678, 5653.265075540154, 5487.0, 5507.256520369859, 5514.2004409359615, 5523.0, 5578.804741834017], "value": 4258.325070516864, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [783.3185128937823, 795.4869109424418, 826.983460330793, 852.6802449081595, 881.6825942660641, 15091.0, 16286.185690715476, 16296.0, 16345.182740862969, 16361.427350042752, 15225.086494810319, 15492.302846371913, 15507.922460387683, 15510.224488775544, 15513.84486155138, 668.0980676087291, 794.2613369566301, 804.5333706450259, 815.975520734379, 821.0434843407453, 807.7495976247382, 809.6073404398862, 810.3112354498688, 810.4853418079532, 810.9635066422026, 869.1395518436765, 870.0125357718971, 870.4037734152095, 870.695256660167, 870.8258348330328, 713.1869668577825, 862.8317478091775, 872.5898827551041, 876.2814492116468, 887.3344991256557, 616.9259688837324, 629.238621268266, 630.1492984470973, 631.2803404119308, 631.7915088020942, 14640.267986600735, 14732.926335368255, 14805.185714785683, 14816.851831481656, 14822.481213157596, 14544.70910581793, 14597.12417254968, 15223.0, 15634.765478517831, 15859.286332115082, 12568.685782855411, 12753.744925101539, 12754.36228188587, 12791.296478693668, 13361.66595835102, 3943.132510847609, 3946.5264168299987, 3979.5025621797276, 4010.498687664042, 4121.979390103031, 76248.61875690587, 76788.61605691991, 76883.61558192174, 78965.60517197434, 80620.59689701514, 11357.94321028406, 11383.146264030065, 11499.195056346143, 11562.88437115635, 12154.270743755404, 23407.41481462977, 23427.531449371258, 23497.295081147593, 23515.52968940646, 23653.763462365157, 8414.621342039623, 8455.830883382298, 8471.915280847235, 8668.696595619123, 8782.121787821166, 4616.6306695464955, 4744.24092145262, 4744.976275118603, 4891.290762839369, 4921.680090794087, 3709.8330575123646, 3781.0736369589627, 3809.1810260794064, 3811.7903515306925, 3813.046738315421, 548.7859734703469, 612.5620181570199, 617.1267656266423, 619.1548536247989, 643.1638869469764, 601.9939800602026, 662.3277373465936, 751.7368920877649, 757.526545908807, 760.7223363472293, 9744.75638109053, 10100.686910701561, 10352.223583231287, 10520.165961955396, 10525.263231573716, 682.931706829323, 723.8588475247276, 728.1735230513406, 729.3946024799404, 743.9516431431939, 5057.115004874206, 5068.619853510928, 5118.206677964921, 5180.248863914711, 5190.247414125006, 111104.0, 111600.0, 117546.0, 119261.40369298271, 120200.39899800446, 100677.0, 102960.0, 106578.0, 107555.46222268838, 107766.0, 86598.56700716456, 87640.0, 87764.0, 88195.55902220577, 88494.0, 10477.214208934209, 10495.685129446128, 10534.631287904887, 10700.892991070301, 11017.11863050938, 36339.0, 38036.80981595185, 44212.7789361064, 53091.734541327045, 53774.19338710001, 49054.75472622614, 50630.2405463911, 63436.0, 66321.0, 78928.21071789438, 13087.149335293176, 13311.400986955416, 13352.799708004193, 13465.663358416117, 13895.37470813836, 14089.718205636034, 14145.717085658434, 14158.575242742734, 14267.785983210053, 14857.925710371812, 13961.0, 14499.752538356572, 14515.274236287933, 14666.011933990856, 14926.328315225624, 13508.594742157751, 13547.0, 14776.926115369355, 14788.408463661333, 14905.646229598253, 13765.449382024606, 14305.57083287503, 14312.499062532761, 14527.128372297697, 14898.404063837324, 11212.887871121184, 11479.770404592029, 11680.9881847478, 11778.352190629597, 12129.939350303192, 10218.540165692413, 10500.264981451224, 10773.983368952291, 11881.643550693492, 12202.694932626755], "value": 7713.944597302113, "unit": "score"}], "name": "dromaeo_css", "value": 7333.486387586792, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 111.0, 110.0, 111.0, 111.0, 112.0, 109.0, 111.0, 112.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 116.0, 119.0, 180.0, 122.0, 124.0, 146.0, 117.0, 151.0, 116.0], "value": 133.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 160.0, 161.0, 161.0, 161.0, 160.0, 162.0, 160.0, 162.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 113.0, 75.0, 75.0, 73.0, 74.0, 97.0, 74.0], "value": 80.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 113.0, 84.0, 85.0, 84.0, 122.0, 84.0, 83.0, 128.0], "value": 95.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 145.0, 146.0, 145.0, 146.0, 147.0, 146.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 52.0, 54.0, 54.0, 53.0, 54.0, 53.0, 53.0, 58.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 63.0, 63.0, 62.0, 62.0, 64.0, 63.0], "value": 62.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 75.0, 84.0, 77.0, 75.0, 76.0, 75.0, 79.0], "value": 76.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 121.0, 120.0, 128.0, 119.0, 125.0, 120.0, 119.0, 174.0, 120.0], "value": 127.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 153.0, 156.0, 156.0, 158.0, 154.0, 158.0, 156.0, 152.0, 156.0], "value": 155.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 63.0, 66.0, 62.0, 63.0, 62.0, 64.0, 62.0], "value": 63.2, "unit": "score"}], "name": "kraken", "value": 1476.6000000000001, "alertThreshold": 2.0}]} 13:06:02 INFO - Return code: 0 13:06:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:06:02 INFO - # TBPL SUCCESS # 13:06:02 INFO - Running post-action listener: _resource_record_post_action 13:06:02 INFO - [mozharness: 2016-07-21 20:06:02.200086Z] Finished run-tests step (success) 13:06:02 INFO - Running post-run listener: _resource_record_post_run 13:06:02 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 562126848; Read time: 28; Write time: 1164812 13:06:02 INFO - TinderboxPrint: CPU usage
13.1% 13:06:02 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 28 13:06:02 INFO - TinderboxPrint: I/O write bytes / time
562,126,848 / 1,164,812 13:06:02 INFO - TinderboxPrint: CPU idle
8,297.1 (86.9%) 13:06:02 INFO - TinderboxPrint: CPU user
1,192.1 (12.5%) 13:06:02 INFO - TinderboxPrint: Swap in / out
0 / 0 13:06:02 INFO - install - Wall time: 19s; CPU: 17.0%; Read bytes: 0; Write bytes: 266518528; Read time: 0; Write time: 643584 13:06:02 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294993920; Read time: 28; Write time: 521228 13:06:02 INFO - Running post-run listener: _upload_blobber_files 13:06:02 INFO - Blob upload gear active. 13:06:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:06:02 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:06:02 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'] 13:06:02 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 13:06:03 INFO - (blobuploader) - INFO - Open directory for files ... 13:06:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:06:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:06:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:06:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:06:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:06:14 INFO - (blobuploader) - INFO - Done attempting. 13:06:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:06:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:06:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:06:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:06:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:06:15 INFO - (blobuploader) - INFO - Done attempting. 13:06:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:06:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:06:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:06:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:06:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:06:16 INFO - (blobuploader) - INFO - Done attempting. 13:06:16 INFO - (blobuploader) - INFO - Iteration through files over. 13:06:16 INFO - Return code: 0 13:06:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:06:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:06:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/92750419c9a7a35bd65f29f3e2e406f99160b34e0539108b62490b02c67e5356133c37f8954ca4e4eb36117d68d3d363fee09afe83d5c64695ba1eda17d01128", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a96337c992c73e3f7dd25445cf2c5ec086d279d767c34191962f6ba585e4c32afcf063bc1da102f5a8a9b65a14cf28f1aa257016926672c986dbbef7451da18", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/83c1d2de190c8a795a2e463e5829987ee5eeb609a16ef4217a4a29d178950ee48b5fbdb461d518cfabfbd7f6aeadf5ebeaf932be98fd5103e3afe646d5b67d1c"} 13:06:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:06:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:06:16 INFO - Contents: 13:06:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/92750419c9a7a35bd65f29f3e2e406f99160b34e0539108b62490b02c67e5356133c37f8954ca4e4eb36117d68d3d363fee09afe83d5c64695ba1eda17d01128", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a96337c992c73e3f7dd25445cf2c5ec086d279d767c34191962f6ba585e4c32afcf063bc1da102f5a8a9b65a14cf28f1aa257016926672c986dbbef7451da18", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/83c1d2de190c8a795a2e463e5829987ee5eeb609a16ef4217a4a29d178950ee48b5fbdb461d518cfabfbd7f6aeadf5ebeaf932be98fd5103e3afe646d5b67d1c"} 13:06:16 INFO - Running post-run listener: copy_logs_to_upload_dir 13:06:16 INFO - Copying logs to upload dir... 13:06:16 INFO - mkdir: /builds/slave/test/build/upload/logs 13:06:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.352665 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-07-21 13:06:16.023304) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 13:06:16.027256) ========= 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=745a4373a2a16df560f216e000000264-1469130332.78696-1346484126 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/92750419c9a7a35bd65f29f3e2e406f99160b34e0539108b62490b02c67e5356133c37f8954ca4e4eb36117d68d3d363fee09afe83d5c64695ba1eda17d01128", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a96337c992c73e3f7dd25445cf2c5ec086d279d767c34191962f6ba585e4c32afcf063bc1da102f5a8a9b65a14cf28f1aa257016926672c986dbbef7451da18", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/83c1d2de190c8a795a2e463e5829987ee5eeb609a16ef4217a4a29d178950ee48b5fbdb461d518cfabfbd7f6aeadf5ebeaf932be98fd5103e3afe646d5b67d1c"} build_url:https://queue.taskcluster.net/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011326 build_url: 'https://queue.taskcluster.net/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/92750419c9a7a35bd65f29f3e2e406f99160b34e0539108b62490b02c67e5356133c37f8954ca4e4eb36117d68d3d363fee09afe83d5c64695ba1eda17d01128", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a96337c992c73e3f7dd25445cf2c5ec086d279d767c34191962f6ba585e4c32afcf063bc1da102f5a8a9b65a14cf28f1aa257016926672c986dbbef7451da18", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/83c1d2de190c8a795a2e463e5829987ee5eeb609a16ef4217a4a29d178950ee48b5fbdb461d518cfabfbd7f6aeadf5ebeaf932be98fd5103e3afe646d5b67d1c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 13:06:16.059279) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 13:06:16.059896) ========= 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=745a4373a2a16df560f216e000000264-1469130332.78696-1346484126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004427 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 13:06:16.144702) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 13:06:16.145213) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 13:06:16.145695) ========= ========= Total master_lag: 0.18 =========