builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-004 starttime: 1467288198.58 results: success (0) buildid: 20160630035327 builduid: 32072485d7a5448eac72d3a088240fb6 revision: 7b4e8a8e4f0b3a13e0862d8b54f7e9967069b6d9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 05:03:18.577927) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 05:03:18.578684) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 05:03:18.579014) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 05:03:18.594746) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 05:03:18.595172) ========= 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=c6927cf182745ad25b1d38b9000001fe-1467288197.905028-419343367 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-30 05:03:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 66.9M=0s 2016-06-30 05:03:18 (66.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120508 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 05:03:18.731109) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 05:03:18.731490) ========= 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=c6927cf182745ad25b1d38b9000001fe-1467288197.905028-419343367 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017379 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 05:03:18.781648) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-30 05:03:18.782048) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7b4e8a8e4f0b3a13e0862d8b54f7e9967069b6d9 --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 7b4e8a8e4f0b3a13e0862d8b54f7e9967069b6d9 --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=c6927cf182745ad25b1d38b9000001fe-1467288197.905028-419343367 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-30 05:03:18,882 truncating revision to first 12 chars 2016-06-30 05:03:18,882 Setting DEBUG logging. 2016-06-30 05:03:18,882 attempt 1/10 2016-06-30 05:03:18,882 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7b4e8a8e4f0b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-30 05:03:20,301 unpacking tar archive at: fx-team-7b4e8a8e4f0b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.730967 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-30 05:03:20.529279) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 05:03:20.529919) ========= script_repo_revision: 7b4e8a8e4f0b3a13e0862d8b54f7e9967069b6d9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 05:03:20.530753) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 05:03:20.531080) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 05:03:20.542175) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-30 05:03:20.542547) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1467288197.905028-419343367 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:03:20 INFO - MultiFileLogger online at 20160630 05:03:20 in /builds/slave/test 05:03:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 05:03:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:03:20 INFO - {'append_to_log': False, 05:03:20 INFO - 'base_work_dir': '/builds/slave/test', 05:03:20 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:03:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:03:20 INFO - 'branch': 'Fx-Team-Non-PGO', 05:03:20 INFO - 'buildbot_json_path': 'buildprops.json', 05:03:20 INFO - 'config_files': ('talos/linux_config.py',), 05:03:20 INFO - 'default_actions': ('clobber', 05:03:20 INFO - 'read-buildbot-config', 05:03:20 INFO - 'download-and-extract', 05:03:20 INFO - 'populate-webroot', 05:03:20 INFO - 'create-virtualenv', 05:03:20 INFO - 'install', 05:03:20 INFO - 'run-tests'), 05:03:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:03:20 INFO - 'download_minidump_stackwalk': True, 05:03:20 INFO - 'download_symbols': 'ondemand', 05:03:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:03:20 INFO - 'tooltool.py': '/tools/tooltool.py', 05:03:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:03:20 INFO - '/tools/misc-python/virtualenv.py')}, 05:03:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:03:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:03:20 INFO - 'installer_path': 'installer.exe', 05:03:20 INFO - 'log_level': 'info', 05:03:20 INFO - 'log_name': 'talos', 05:03:20 INFO - 'log_to_console': True, 05:03:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:03:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:03:20 INFO - 'opt_config_files': (), 05:03:20 INFO - 'pip_index': False, 05:03:20 INFO - 'sps_profile': False, 05:03:20 INFO - 'sps_profile_interval': 0, 05:03:20 INFO - 'suite': 'dromaeojs-e10s', 05:03:20 INFO - 'system_bits': '32', 05:03:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:03:20 INFO - 'title': 'talos-linux64-ix-004', 05:03:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:03:20 INFO - 'use_talos_json': True, 05:03:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:03:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:03:20 INFO - 'work_dir': 'build'} 05:03:20 INFO - ##### 05:03:20 INFO - ##### Running clobber step. 05:03:20 INFO - ##### 05:03:20 INFO - Running pre-action listener: _resource_record_pre_action 05:03:20 INFO - Running main action method: clobber 05:03:20 INFO - rmtree: /builds/slave/test/build 05:03:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:03:21 INFO - Running post-action listener: _resource_record_post_action 05:03:21 INFO - ##### 05:03:21 INFO - ##### Finished clobber step (success) 05:03:21 INFO - ##### 05:03:21 INFO - ##### 05:03:21 INFO - ##### Running read-buildbot-config step. 05:03:21 INFO - ##### 05:03:21 INFO - Running pre-action listener: _resource_record_pre_action 05:03:21 INFO - Running main action method: read_buildbot_config 05:03:21 INFO - Using buildbot properties: 05:03:21 INFO - { 05:03:21 INFO - "project": "", 05:03:21 INFO - "product": "firefox", 05:03:21 INFO - "script_repo_revision": "production", 05:03:21 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:03:21 INFO - "repository": "", 05:03:21 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 05:03:21 INFO - "buildid": "20160630035327", 05:03:21 INFO - "pgo_build": "False", 05:03:21 INFO - "basedir": "/builds/slave/test", 05:03:21 INFO - "buildnumber": 1451, 05:03:21 INFO - "slavename": "talos-linux64-ix-004", 05:03:21 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:03:21 INFO - "platform": "ubuntu64_hw", 05:03:21 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:03:21 INFO - "branch": "fx-team", 05:03:21 INFO - "repo_path": "integration/fx-team", 05:03:21 INFO - "revision": "7b4e8a8e4f0b3a13e0862d8b54f7e9967069b6d9", 05:03:21 INFO - "stage_platform": "linux64", 05:03:21 INFO - "builduid": "32072485d7a5448eac72d3a088240fb6", 05:03:21 INFO - "slavebuilddir": "test" 05:03:21 INFO - } 05:03:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/ElQf9aGWRkSR9qchoFWwNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:03:21 INFO - Running post-action listener: _resource_record_post_action 05:03:21 INFO - ##### 05:03:21 INFO - ##### Finished read-buildbot-config step (success) 05:03:21 INFO - ##### 05:03:21 INFO - ##### 05:03:21 INFO - ##### Running download-and-extract step. 05:03:21 INFO - ##### 05:03:21 INFO - Running pre-action listener: _resource_record_pre_action 05:03:21 INFO - Running main action method: download_and_extract 05:03:21 INFO - mkdir: /builds/slave/test/build/tests 05:03:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:03:21 INFO - https://queue.taskcluster.net/v1/task/ElQf9aGWRkSR9qchoFWwNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:03:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ElQf9aGWRkSR9qchoFWwNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:03:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ElQf9aGWRkSR9qchoFWwNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:03:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ElQf9aGWRkSR9qchoFWwNA/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 05:03:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ElQf9aGWRkSR9qchoFWwNA/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 05:03:21 INFO - Downloaded 1361 bytes. 05:03:21 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:03:21 INFO - Using the following test package requirements: 05:03:21 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:03:21 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:03:21 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:03:21 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:21 INFO - u'jsshell-linux-x86_64.zip'], 05:03:21 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:03:21 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:03:21 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:03:21 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:03:21 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:03:21 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:03:21 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:03:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:03:21 INFO - https://queue.taskcluster.net/v1/task/ElQf9aGWRkSR9qchoFWwNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:03:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ElQf9aGWRkSR9qchoFWwNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:03:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ElQf9aGWRkSR9qchoFWwNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:03:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ElQf9aGWRkSR9qchoFWwNA/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 05:03:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ElQf9aGWRkSR9qchoFWwNA/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 05:03:24 INFO - Downloaded 22701713 bytes. 05:03:24 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'] 05:03:24 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 05:03:25 INFO - Return code: 0 05:03:25 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 05:03:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:03:25 INFO - https://queue.taskcluster.net/v1/task/ElQf9aGWRkSR9qchoFWwNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:03:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ElQf9aGWRkSR9qchoFWwNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:03:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ElQf9aGWRkSR9qchoFWwNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:03:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ElQf9aGWRkSR9qchoFWwNA/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 05:03:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ElQf9aGWRkSR9qchoFWwNA/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 05:03:27 INFO - Downloaded 22701713 bytes. 05:03:27 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'] 05:03:27 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 05:03:28 INFO - Return code: 0 05:03:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:03:28 INFO - https://queue.taskcluster.net/v1/task/ElQf9aGWRkSR9qchoFWwNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:03:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ElQf9aGWRkSR9qchoFWwNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:03:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ElQf9aGWRkSR9qchoFWwNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:03:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ElQf9aGWRkSR9qchoFWwNA/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 05:03:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ElQf9aGWRkSR9qchoFWwNA/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 05:03:30 INFO - Downloaded 14405242 bytes. 05:03:30 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'] 05:03:30 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 05:03:30 INFO - Return code: 0 05:03:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:03:30 INFO - https://queue.taskcluster.net/v1/task/ElQf9aGWRkSR9qchoFWwNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:03:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ElQf9aGWRkSR9qchoFWwNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:03:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ElQf9aGWRkSR9qchoFWwNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:03:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ElQf9aGWRkSR9qchoFWwNA/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 05:03:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ElQf9aGWRkSR9qchoFWwNA/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 05:03:35 INFO - Downloaded 56449665 bytes. 05:03:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ElQf9aGWRkSR9qchoFWwNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:03:35 INFO - mkdir: /builds/slave/test/properties 05:03:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:03:35 INFO - Writing to file /builds/slave/test/properties/build_url 05:03:35 INFO - Contents: 05:03:35 INFO - build_url:https://queue.taskcluster.net/v1/task/ElQf9aGWRkSR9qchoFWwNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:03:35 INFO - Running post-action listener: _resource_record_post_action 05:03:35 INFO - Running post-action listener: set_extra_try_arguments 05:03:35 INFO - ##### 05:03:35 INFO - ##### Finished download-and-extract step (success) 05:03:35 INFO - ##### 05:03:35 INFO - ##### 05:03:35 INFO - ##### Running populate-webroot step. 05:03:35 INFO - ##### 05:03:35 INFO - Running pre-action listener: _resource_record_pre_action 05:03:35 INFO - Running main action method: populate_webroot 05:03:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:03:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:03:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:03:35 INFO - '--tppagecycles', 05:03:35 INFO - '7'], 05:03:35 INFO - 'tests': ['tsvgm']}}, 05:03:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:03:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:03:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:03:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:03:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:03:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:03:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:35 INFO - 'talos_options': ['--disable-e10s'], 05:03:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:03:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:03:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:35 INFO - 'talos_options': ['--disable-e10s'], 05:03:35 INFO - 'tests': ['damp', 'tps']}, 05:03:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:35 INFO - 'tests': ['damp', 'tps']}, 05:03:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:03:35 INFO - 'tests': ['dromaeo_dom']}, 05:03:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:03:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:03:35 INFO - 'tests': ['basic_compositor_video']}, 05:03:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:03:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:03:35 INFO - 'tests': ['a11yr', 05:03:35 INFO - 'ts_paint', 05:03:35 INFO - 'tpaint', 05:03:35 INFO - 'sessionrestore', 05:03:35 INFO - 'sessionrestore_no_auto_restore', 05:03:35 INFO - 'tabpaint']}, 05:03:35 INFO - 'other-e10s': {'tests': ['a11yr', 05:03:35 INFO - 'ts_paint', 05:03:35 INFO - 'tpaint', 05:03:35 INFO - 'sessionrestore', 05:03:35 INFO - 'sessionrestore_no_auto_restore', 05:03:35 INFO - 'tabpaint']}, 05:03:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:03:35 INFO - 'ts_paint', 05:03:35 INFO - 'tpaint', 05:03:35 INFO - 'sessionrestore', 05:03:35 INFO - 'sessionrestore_no_auto_restore', 05:03:35 INFO - 'tabpaint']}, 05:03:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:03:35 INFO - 'ts_paint', 05:03:35 INFO - 'tpaint', 05:03:35 INFO - 'sessionrestore', 05:03:35 INFO - 'sessionrestore_no_auto_restore', 05:03:35 INFO - 'tabpaint']}, 05:03:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:03:35 INFO - 'tests': ['a11yr', 05:03:35 INFO - 'ts_paint', 05:03:35 INFO - 'tpaint', 05:03:35 INFO - 'sessionrestore', 05:03:35 INFO - 'sessionrestore_no_auto_restore', 05:03:35 INFO - 'tabpaint']}, 05:03:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:03:35 INFO - 'tests': ['a11yr', 05:03:35 INFO - 'ts_paint', 05:03:35 INFO - 'tpaint', 05:03:35 INFO - 'sessionrestore', 05:03:35 INFO - 'sessionrestore_no_auto_restore', 05:03:35 INFO - 'tabpaint']}, 05:03:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:03:35 INFO - 'tests': ['tsvgx', 05:03:35 INFO - 'tsvgr_opacity', 05:03:35 INFO - 'tart', 05:03:35 INFO - 'tscrollx', 05:03:35 INFO - 'cart']}, 05:03:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:03:35 INFO - 'tsvgr_opacity', 05:03:35 INFO - 'tart', 05:03:35 INFO - 'tscrollx', 05:03:35 INFO - 'cart']}, 05:03:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:35 INFO - 'talos_options': ['--disable-e10s'], 05:03:35 INFO - 'tests': ['tp5o']}, 05:03:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:35 INFO - 'tests': ['tp5o']}, 05:03:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:35 INFO - 'talos_options': ['--disable-e10s', 05:03:35 INFO - '--xperf_path', 05:03:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:03:35 INFO - 'tests': ['tp5n']}, 05:03:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:35 INFO - 'talos_options': ['--xperf_path', 05:03:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:03:35 INFO - 'tests': ['tp5n']}}, 05:03:35 INFO - 'talos.zip': {'path': '', 05:03:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:03:35 INFO - Running post-action listener: _resource_record_post_action 05:03:35 INFO - ##### 05:03:35 INFO - ##### Finished populate-webroot step (success) 05:03:35 INFO - ##### 05:03:35 INFO - ##### 05:03:35 INFO - ##### Running create-virtualenv step. 05:03:35 INFO - ##### 05:03:35 INFO - Running pre-action listener: _resource_record_pre_action 05:03:35 INFO - Running main action method: create_virtualenv 05:03:35 INFO - Creating virtualenv /builds/slave/test/build/venv 05:03:35 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:03:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:03:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:03:35 INFO - Using real prefix '/usr' 05:03:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:03:36 INFO - Installing distribute.............................................................................................................................................................................................done. 05:03:38 INFO - Installing pip.................done. 05:03:38 INFO - Return code: 0 05:03:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:03: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')]} 05:03:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03: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')]} 05:03:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x242e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ec570>, '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 0x26ed470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ed900>, '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': 'c6927cf182745ad25b1d38b9000001fe-1467288197.905028-419343367', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:03:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:03:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:03:38 INFO - Using env: {'DISPLAY': ':0', 05:03:38 INFO - 'HOME': '/home/cltbld', 05:03:38 INFO - 'LANG': 'en_US.UTF-8', 05:03:38 INFO - 'LANGUAGE': 'en_US:en', 05:03:38 INFO - 'LOGNAME': 'cltbld', 05:03:38 INFO - 'MAIL': '/var/mail/cltbld', 05:03:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:38 INFO - 'MOZ_NO_REMOTE': '1', 05:03:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:38 INFO - 'NO_EM_RESTART': '1', 05:03:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:38 INFO - 'PWD': '/builds/slave/test', 05:03:38 INFO - 'SHELL': '/bin/bash', 05:03:38 INFO - 'SHLVL': '1', 05:03:38 INFO - 'TERM': 'linux', 05:03:38 INFO - 'TMOUT': '86400', 05:03:38 INFO - 'USER': 'cltbld', 05:03:38 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467288197.905028-419343367', 05:03:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:38 INFO - '_': '/tools/buildbot/bin/python'} 05:03:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:38 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:03:38 INFO - Cleaning up... 05:03:38 INFO - Return code: 0 05:03:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:03: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')]} 05:03:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03: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')]} 05:03:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x242e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ec570>, '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 0x26ed470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ed900>, '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': 'c6927cf182745ad25b1d38b9000001fe-1467288197.905028-419343367', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:03:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:03:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:03:38 INFO - Using env: {'DISPLAY': ':0', 05:03:38 INFO - 'HOME': '/home/cltbld', 05:03:38 INFO - 'LANG': 'en_US.UTF-8', 05:03:38 INFO - 'LANGUAGE': 'en_US:en', 05:03:38 INFO - 'LOGNAME': 'cltbld', 05:03:38 INFO - 'MAIL': '/var/mail/cltbld', 05:03:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:38 INFO - 'MOZ_NO_REMOTE': '1', 05:03:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:38 INFO - 'NO_EM_RESTART': '1', 05:03:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:38 INFO - 'PWD': '/builds/slave/test', 05:03:38 INFO - 'SHELL': '/bin/bash', 05:03:38 INFO - 'SHLVL': '1', 05:03:38 INFO - 'TERM': 'linux', 05:03:38 INFO - 'TMOUT': '86400', 05:03:38 INFO - 'USER': 'cltbld', 05:03:38 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467288197.905028-419343367', 05:03:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:38 INFO - '_': '/tools/buildbot/bin/python'} 05:03:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:38 INFO - Downloading/unpacking psutil>=3.1.1 05:03:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:03:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:03:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:03:40 INFO - Installing collected packages: psutil 05:03:40 INFO - Running setup.py install for psutil 05:03:40 INFO - building 'psutil._psutil_linux' extension 05:03:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:03:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:03:41 INFO - building 'psutil._psutil_posix' extension 05:03:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:03:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:03:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:03:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:03:41 INFO - Successfully installed psutil 05:03:41 INFO - Cleaning up... 05:03:41 INFO - Return code: 0 05:03:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:03: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')]} 05:03:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03: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')]} 05:03:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:41 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 0x242e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ec570>, '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 0x26ed470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ed900>, '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': 'c6927cf182745ad25b1d38b9000001fe-1467288197.905028-419343367', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:03:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:03:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:03:41 INFO - Using env: {'DISPLAY': ':0', 05:03:41 INFO - 'HOME': '/home/cltbld', 05:03:41 INFO - 'LANG': 'en_US.UTF-8', 05:03:41 INFO - 'LANGUAGE': 'en_US:en', 05:03:41 INFO - 'LOGNAME': 'cltbld', 05:03:41 INFO - 'MAIL': '/var/mail/cltbld', 05:03:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:41 INFO - 'MOZ_NO_REMOTE': '1', 05:03:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:41 INFO - 'NO_EM_RESTART': '1', 05:03:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:41 INFO - 'PWD': '/builds/slave/test', 05:03:41 INFO - 'SHELL': '/bin/bash', 05:03:41 INFO - 'SHLVL': '1', 05:03:41 INFO - 'TERM': 'linux', 05:03:41 INFO - 'TMOUT': '86400', 05:03:41 INFO - 'USER': 'cltbld', 05:03:41 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467288197.905028-419343367', 05:03:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:41 INFO - '_': '/tools/buildbot/bin/python'} 05:03:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:03:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:03:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:03:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:03:43 INFO - Installing collected packages: mozsystemmonitor 05:03:43 INFO - Running setup.py install for mozsystemmonitor 05:03:43 INFO - Successfully installed mozsystemmonitor 05:03:43 INFO - Cleaning up... 05:03:43 INFO - Return code: 0 05:03:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:03:43 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')]} 05:03:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:43 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')]} 05:03:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:43 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 0x242e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ec570>, '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 0x26ed470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ed900>, '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': 'c6927cf182745ad25b1d38b9000001fe-1467288197.905028-419343367', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:03:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:03:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:03:43 INFO - Using env: {'DISPLAY': ':0', 05:03:43 INFO - 'HOME': '/home/cltbld', 05:03:43 INFO - 'LANG': 'en_US.UTF-8', 05:03:43 INFO - 'LANGUAGE': 'en_US:en', 05:03:43 INFO - 'LOGNAME': 'cltbld', 05:03:43 INFO - 'MAIL': '/var/mail/cltbld', 05:03:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:43 INFO - 'MOZ_NO_REMOTE': '1', 05:03:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:43 INFO - 'NO_EM_RESTART': '1', 05:03:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:43 INFO - 'PWD': '/builds/slave/test', 05:03:43 INFO - 'SHELL': '/bin/bash', 05:03:43 INFO - 'SHLVL': '1', 05:03:43 INFO - 'TERM': 'linux', 05:03:43 INFO - 'TMOUT': '86400', 05:03:43 INFO - 'USER': 'cltbld', 05:03:43 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467288197.905028-419343367', 05:03:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:43 INFO - '_': '/tools/buildbot/bin/python'} 05:03:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:43 INFO - Downloading/unpacking jsonschema==2.5.1 05:03:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:03:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:46 INFO - Downloading functools32-3.2.3-2.tar.gz 05:03:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:03:46 INFO - warning: no files found matching '*.txt' 05:03:46 INFO - no previously-included directories found matching 'build' 05:03:46 INFO - no previously-included directories found matching 'dist' 05:03:46 INFO - no previously-included directories found matching '.git*' 05:03:46 INFO - Installing collected packages: jsonschema, functools32 05:03:46 INFO - Running setup.py install for functools32 05:03:46 INFO - warning: no files found matching '*.txt' 05:03:46 INFO - no previously-included directories found matching 'build' 05:03:46 INFO - no previously-included directories found matching 'dist' 05:03:46 INFO - no previously-included directories found matching '.git*' 05:03:46 INFO - Successfully installed jsonschema functools32 05:03:46 INFO - Cleaning up... 05:03:46 INFO - Return code: 0 05:03:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:03:46 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')]} 05:03:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:46 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')]} 05:03:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:46 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 0x242e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ec570>, '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 0x26ed470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ed900>, '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': 'c6927cf182745ad25b1d38b9000001fe-1467288197.905028-419343367', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:03:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:03:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:03:46 INFO - Using env: {'DISPLAY': ':0', 05:03:46 INFO - 'HOME': '/home/cltbld', 05:03:46 INFO - 'LANG': 'en_US.UTF-8', 05:03:46 INFO - 'LANGUAGE': 'en_US:en', 05:03:46 INFO - 'LOGNAME': 'cltbld', 05:03:46 INFO - 'MAIL': '/var/mail/cltbld', 05:03:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:46 INFO - 'MOZ_NO_REMOTE': '1', 05:03:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:46 INFO - 'NO_EM_RESTART': '1', 05:03:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:46 INFO - 'PWD': '/builds/slave/test', 05:03:46 INFO - 'SHELL': '/bin/bash', 05:03:46 INFO - 'SHLVL': '1', 05:03:46 INFO - 'TERM': 'linux', 05:03:46 INFO - 'TMOUT': '86400', 05:03:46 INFO - 'USER': 'cltbld', 05:03:46 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467288197.905028-419343367', 05:03:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:46 INFO - '_': '/tools/buildbot/bin/python'} 05:03:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:46 INFO - Downloading/unpacking blobuploader==1.2.4 05:03:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:48 INFO - Downloading blobuploader-1.2.4.tar.gz 05:03:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:03:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:03:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:49 INFO - Downloading docopt-0.6.1.tar.gz 05:03:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:03:49 INFO - Installing collected packages: blobuploader, requests, docopt 05:03:49 INFO - Running setup.py install for blobuploader 05:03:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:03:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:03:49 INFO - Running setup.py install for requests 05:03:49 INFO - Running setup.py install for docopt 05:03:49 INFO - Successfully installed blobuploader requests docopt 05:03:49 INFO - Cleaning up... 05:03:49 INFO - Return code: 0 05:03:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:03:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:03:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:49 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 0x242e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ec570>, '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 0x26ed470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ed900>, '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': 'c6927cf182745ad25b1d38b9000001fe-1467288197.905028-419343367', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:03:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:03:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:03:49 INFO - Using env: {'DISPLAY': ':0', 05:03:49 INFO - 'HOME': '/home/cltbld', 05:03:49 INFO - 'LANG': 'en_US.UTF-8', 05:03:49 INFO - 'LANGUAGE': 'en_US:en', 05:03:49 INFO - 'LOGNAME': 'cltbld', 05:03:49 INFO - 'MAIL': '/var/mail/cltbld', 05:03:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:49 INFO - 'MOZ_NO_REMOTE': '1', 05:03:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:49 INFO - 'NO_EM_RESTART': '1', 05:03:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:49 INFO - 'PWD': '/builds/slave/test', 05:03:49 INFO - 'SHELL': '/bin/bash', 05:03:49 INFO - 'SHLVL': '1', 05:03:49 INFO - 'TERM': 'linux', 05:03:49 INFO - 'TMOUT': '86400', 05:03:49 INFO - 'USER': 'cltbld', 05:03:49 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467288197.905028-419343367', 05:03:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:49 INFO - '_': '/tools/buildbot/bin/python'} 05:03:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:03:50 INFO - Running setup.py (path:/tmp/pip-LNlY4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:03:50 INFO - Running setup.py (path:/tmp/pip-w4Wyos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:03:50 INFO - Running setup.py (path:/tmp/pip-JmSiVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:03:50 INFO - Running setup.py (path:/tmp/pip-IHb0Hj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:03:50 INFO - Running setup.py (path:/tmp/pip-YYgYHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:03:50 INFO - Running setup.py (path:/tmp/pip-PF1Kux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:03:50 INFO - Running setup.py (path:/tmp/pip-n9Bvli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:03:50 INFO - Running setup.py (path:/tmp/pip-JNTOyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:03:50 INFO - Running setup.py (path:/tmp/pip-M1ndvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:03:50 INFO - Running setup.py (path:/tmp/pip-U8haDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:03:50 INFO - Running setup.py (path:/tmp/pip-mEEkRB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:03:50 INFO - Running setup.py (path:/tmp/pip-Jmd2Jv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:03:50 INFO - Running setup.py (path:/tmp/pip-RAN1CB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:03:50 INFO - Running setup.py (path:/tmp/pip-52Mwu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:03:51 INFO - Running setup.py (path:/tmp/pip-ma61uL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:03:51 INFO - Running setup.py (path:/tmp/pip-WBbfha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:03:51 INFO - Running setup.py (path:/tmp/pip-QwyX1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:03:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:03:51 INFO - Running setup.py install for manifestparser 05:03:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:03:51 INFO - Running setup.py install for mozcrash 05:03:51 INFO - Running setup.py install for mozdebug 05:03:51 INFO - Running setup.py install for mozdevice 05:03:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:03:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:03:51 INFO - Running setup.py install for mozfile 05:03:51 INFO - Running setup.py install for mozhttpd 05:03:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:03:51 INFO - Running setup.py install for mozinfo 05:03:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:03:51 INFO - Running setup.py install for mozInstall 05:03:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:03:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:03:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:03:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:03:52 INFO - Running setup.py install for mozleak 05:03:52 INFO - Running setup.py install for mozlog 05:03:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:03:52 INFO - Running setup.py install for moznetwork 05:03:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:03:52 INFO - Running setup.py install for mozprocess 05:03:52 INFO - Running setup.py install for mozprofile 05:03:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:03:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:03:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:03:52 INFO - Running setup.py install for mozrunner 05:03:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:03:52 INFO - Running setup.py install for mozscreenshot 05:03:52 INFO - Running setup.py install for moztest 05:03:52 INFO - Running setup.py install for mozversion 05:03:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:03:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:03:53 INFO - Cleaning up... 05:03:53 INFO - Return code: 0 05:03:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:03:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:03:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:53 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 0x242e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ec570>, '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 0x26ed470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ed900>, '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': 'c6927cf182745ad25b1d38b9000001fe-1467288197.905028-419343367', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:03:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:03:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:03:53 INFO - Using env: {'DISPLAY': ':0', 05:03:53 INFO - 'HOME': '/home/cltbld', 05:03:53 INFO - 'LANG': 'en_US.UTF-8', 05:03:53 INFO - 'LANGUAGE': 'en_US:en', 05:03:53 INFO - 'LOGNAME': 'cltbld', 05:03:53 INFO - 'MAIL': '/var/mail/cltbld', 05:03:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:53 INFO - 'MOZ_NO_REMOTE': '1', 05:03:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:53 INFO - 'NO_EM_RESTART': '1', 05:03:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:53 INFO - 'PWD': '/builds/slave/test', 05:03:53 INFO - 'SHELL': '/bin/bash', 05:03:53 INFO - 'SHLVL': '1', 05:03:53 INFO - 'TERM': 'linux', 05:03:53 INFO - 'TMOUT': '86400', 05:03:53 INFO - 'USER': 'cltbld', 05:03:53 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467288197.905028-419343367', 05:03:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:53 INFO - '_': '/tools/buildbot/bin/python'} 05:03:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:03:53 INFO - Running setup.py (path:/tmp/pip-LX0AKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:03:53 INFO - Running setup.py (path:/tmp/pip-yYosE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:03:53 INFO - Running setup.py (path:/tmp/pip-UFhlzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:03:53 INFO - Running setup.py (path:/tmp/pip-cl1g0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:03:53 INFO - Running setup.py (path:/tmp/pip-yMxRv6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:03:53 INFO - Running setup.py (path:/tmp/pip-vhWD2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:03:53 INFO - Running setup.py (path:/tmp/pip-azdq8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:03:53 INFO - Running setup.py (path:/tmp/pip-rtJaWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:03:53 INFO - Running setup.py (path:/tmp/pip-JTVrwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:03:53 INFO - Running setup.py (path:/tmp/pip-VAQpI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:03:53 INFO - Running setup.py (path:/tmp/pip-5lN6L7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:03:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:03:54 INFO - Running setup.py (path:/tmp/pip-OBwOXW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:03:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:03:54 INFO - Running setup.py (path:/tmp/pip-Z_ZzdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:03:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:03:54 INFO - Running setup.py (path:/tmp/pip-bNHdpl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:03:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:03:54 INFO - Running setup.py (path:/tmp/pip-MNgsNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:03:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:03:54 INFO - Running setup.py (path:/tmp/pip-UbfnLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:03:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:03:54 INFO - Running setup.py (path:/tmp/pip-yFfxG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:03:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:03:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:03:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:03:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:03:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:03:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:03:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:03: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 05:03: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 05:03: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 05:03: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 05:03: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 05:03: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 05:03:56 INFO - Downloading blessings-1.6.tar.gz 05:03:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:03:56 INFO - Installing collected packages: blessings 05:03:56 INFO - Running setup.py install for blessings 05:03:56 INFO - Successfully installed blessings 05:03:56 INFO - Cleaning up... 05:03:56 INFO - Return code: 0 05:03:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:03:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:03:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:03:56 INFO - Reading from file tmpfile_stdout 05:03:56 INFO - Current package versions: 05:03:56 INFO - argparse == 1.2.1 05:03:56 INFO - blessings == 1.6 05:03:56 INFO - blobuploader == 1.2.4 05:03:56 INFO - docopt == 0.6.1 05:03:56 INFO - functools32 == 3.2.3-2 05:03:56 INFO - jsonschema == 2.5.1 05:03:56 INFO - manifestparser == 1.1 05:03:56 INFO - mozInstall == 1.12 05:03:56 INFO - mozcrash == 0.17 05:03:56 INFO - mozdebug == 0.1 05:03:56 INFO - mozdevice == 0.48 05:03:56 INFO - mozfile == 1.2 05:03:56 INFO - mozhttpd == 0.7 05:03:56 INFO - mozinfo == 0.9 05:03:56 INFO - mozleak == 0.1 05:03:56 INFO - mozlog == 3.2 05:03:56 INFO - moznetwork == 0.27 05:03:56 INFO - mozprocess == 0.22 05:03:56 INFO - mozprofile == 0.28 05:03:56 INFO - mozrunner == 6.11 05:03:56 INFO - mozscreenshot == 0.1 05:03:56 INFO - mozsystemmonitor == 0.3 05:03:56 INFO - moztest == 0.7 05:03:56 INFO - mozversion == 1.4 05:03:56 INFO - psutil == 3.1.1 05:03:56 INFO - requests == 1.2.3 05:03:56 INFO - wsgiref == 0.1.2 05:03:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:03:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:03:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:56 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 0x242e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ec570>, '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 0x26ed470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ed900>, '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': 'c6927cf182745ad25b1d38b9000001fe-1467288197.905028-419343367', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:03:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:03:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:03:56 INFO - Using env: {'DISPLAY': ':0', 05:03:56 INFO - 'HOME': '/home/cltbld', 05:03:56 INFO - 'LANG': 'en_US.UTF-8', 05:03:56 INFO - 'LANGUAGE': 'en_US:en', 05:03:56 INFO - 'LOGNAME': 'cltbld', 05:03:56 INFO - 'MAIL': '/var/mail/cltbld', 05:03:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:56 INFO - 'MOZ_NO_REMOTE': '1', 05:03:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:56 INFO - 'NO_EM_RESTART': '1', 05:03:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:56 INFO - 'PWD': '/builds/slave/test', 05:03:56 INFO - 'SHELL': '/bin/bash', 05:03:56 INFO - 'SHLVL': '1', 05:03:56 INFO - 'TERM': 'linux', 05:03:56 INFO - 'TMOUT': '86400', 05:03:56 INFO - 'USER': 'cltbld', 05:03:56 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467288197.905028-419343367', 05:03:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:56 INFO - '_': '/tools/buildbot/bin/python'} 05:03:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:03:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:03:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:03:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:03:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:03:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:03:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:03:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:03:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:03:57 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:03:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:03:57 INFO - Cleaning up... 05:03:57 INFO - Return code: 0 05:03:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:03:57 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')]} 05:03:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:57 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')]} 05:03:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:57 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 0x242e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ec570>, '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 0x26ed470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ed900>, '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': 'c6927cf182745ad25b1d38b9000001fe-1467288197.905028-419343367', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:03:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:03:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:03:57 INFO - Using env: {'DISPLAY': ':0', 05:03:57 INFO - 'HOME': '/home/cltbld', 05:03:57 INFO - 'LANG': 'en_US.UTF-8', 05:03:57 INFO - 'LANGUAGE': 'en_US:en', 05:03:57 INFO - 'LOGNAME': 'cltbld', 05:03:57 INFO - 'MAIL': '/var/mail/cltbld', 05:03:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:57 INFO - 'MOZ_NO_REMOTE': '1', 05:03:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:57 INFO - 'NO_EM_RESTART': '1', 05:03:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:57 INFO - 'PWD': '/builds/slave/test', 05:03:57 INFO - 'SHELL': '/bin/bash', 05:03:57 INFO - 'SHLVL': '1', 05:03:57 INFO - 'TERM': 'linux', 05:03:57 INFO - 'TMOUT': '86400', 05:03:57 INFO - 'USER': 'cltbld', 05:03:57 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467288197.905028-419343367', 05:03:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:57 INFO - '_': '/tools/buildbot/bin/python'} 05:03:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:03:57 INFO - Cleaning up... 05:03:57 INFO - Return code: 0 05:03:57 INFO - Running post-action listener: _resource_record_post_action 05:03:57 INFO - Running post-action listener: _start_resource_monitoring 05:03:57 INFO - Starting resource monitoring. 05:03:57 INFO - ##### 05:03:57 INFO - ##### Finished create-virtualenv step (success) 05:03:57 INFO - ##### 05:03:57 INFO - ##### 05:03:57 INFO - ##### Running install step. 05:03:57 INFO - ##### 05:03:57 INFO - Running pre-action listener: _resource_record_pre_action 05:03:57 INFO - Running main action method: install 05:03:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:03:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:03:57 INFO - Reading from file tmpfile_stdout 05:03:57 INFO - Detecting whether we're running mozinstall >=1.0... 05:03:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:03:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:03:57 INFO - Reading from file tmpfile_stdout 05:03:57 INFO - Output received: 05:03:57 INFO - Usage: mozinstall [options] installer 05:03:57 INFO - Options: 05:03:57 INFO - -h, --help show this help message and exit 05:03:57 INFO - -d DEST, --destination=DEST 05:03:57 INFO - Directory to install application into. [default: 05:03:57 INFO - "/builds/slave/test"] 05:03:57 INFO - --app=APP Application being installed. [default: firefox] 05:03:57 INFO - mkdir: /builds/slave/test/build/application 05:03:57 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'] 05:03:57 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 05:04:13 INFO - Reading from file tmpfile_stdout 05:04:13 INFO - Output received: 05:04:13 INFO - /builds/slave/test/build/application/firefox/firefox 05:04:13 INFO - Running post-action listener: _resource_record_post_action 05:04:13 INFO - ##### 05:04:13 INFO - ##### Finished install step (success) 05:04:13 INFO - ##### 05:04:13 INFO - ##### 05:04:13 INFO - ##### Running run-tests step. 05:04:13 INFO - ##### 05:04:13 INFO - Running pre-action listener: _resource_record_pre_action 05:04:13 INFO - Running main action method: run_tests 05:04:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:04:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:04:13 INFO - Python 2.7.3 05:04:13 INFO - Return code: 0 05:04:13 INFO - grabbing minidump binary from tooltool 05:04:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:04:13 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 0x26ec570>, '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 0x26ed470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ed900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:04:13 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:04:13 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:04:13 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:04:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:04:14 INFO - Return code: 0 05:04:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:04:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:04:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:04:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:04:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:04:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ElQf9aGWRkSR9qchoFWwNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:04:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ElQf9aGWRkSR9qchoFWwNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:04:14 INFO - Using env: {'DISPLAY': ':0', 05:04:14 INFO - 'HOME': '/home/cltbld', 05:04:14 INFO - 'LANG': 'en_US.UTF-8', 05:04:14 INFO - 'LANGUAGE': 'en_US:en', 05:04:14 INFO - 'LOGNAME': 'cltbld', 05:04:14 INFO - 'MAIL': '/var/mail/cltbld', 05:04:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:04:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:04:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:14 INFO - 'MOZ_NO_REMOTE': '1', 05:04:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:04:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:14 INFO - 'NO_EM_RESTART': '1', 05:04:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:14 INFO - 'PWD': '/builds/slave/test', 05:04:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:04:14 INFO - 'SHELL': '/bin/bash', 05:04:14 INFO - 'SHLVL': '1', 05:04:14 INFO - 'TERM': 'linux', 05:04:14 INFO - 'TMOUT': '86400', 05:04:14 INFO - 'USER': 'cltbld', 05:04:14 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467288197.905028-419343367', 05:04:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:14 INFO - '_': '/tools/buildbot/bin/python'} 05:04:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ElQf9aGWRkSR9qchoFWwNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:04:14 INFO - mozversion application_buildid: 20160630035327 05:04:14 INFO - mozversion application_changeset: 7b4e8a8e4f0b3a13e0862d8b54f7e9967069b6d9 05:04:14 INFO - mozversion application_display_name: Nightly 05:04:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:04:14 INFO - mozversion application_name: Firefox 05:04:14 INFO - mozversion application_remotingname: firefox 05:04:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:04:14 INFO - mozversion application_vendor: Mozilla 05:04:14 INFO - mozversion application_version: 50.0a1 05:04:14 INFO - mozversion platform_buildid: 20160630035327 05:04:14 INFO - mozversion platform_changeset: 7b4e8a8e4f0b3a13e0862d8b54f7e9967069b6d9 05:04:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:04:14 INFO - mozversion platform_version: 50.0a1 05:04:14 INFO - using testdate: 1467288254 05:04:14 INFO - actual date: 1467288254 05:04:14 INFO - starting webserver on 'localhost:34327' 05:04:14 INFO - SUITE-START | Running 2 tests 05:04:14 INFO - TEST-START | dromaeo_css 05:04:14 INFO - operating with platform_type : linux_ 05:04:14 INFO - Initialising browser for dromaeo_css test... 05:04:14 INFO - TEST-INFO | started process 10242 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ7Gd9v/profile http://localhost:34327/getInfo.html) 05:04:19 INFO - PROCESS | 10242 | __metrics Screen width/height:1600/1200 05:04:19 INFO - PROCESS | 10242 | colorDepth:24 05:04:19 INFO - PROCESS | 10242 | Browser inner width/height: 1024/697 05:04:19 INFO - PROCESS | 10242 | __metrics 05:04:20 ERROR - PROCESS | 10242 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 05:04:21 INFO - TEST-INFO | 10242: exit 0 05:04:21 INFO - Browser initialized. 05:04:21 INFO - Running cycle 1/1 for dromaeo_css test... 05:04:21 INFO - TEST-INFO | started process 10363 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ7Gd9v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:04:32 INFO - PROCESS | 10363 | RSS: Main: 169881600 05:04:32 INFO - PROCESS | 10363 | 05:05:22 INFO - PROCESS | 10363 | 1467288322520 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:07:34 INFO - PROCESS | 10363 | Cycle 1(1): loaded http://localhost:34327/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34327/tests/dromaeo/cssquery-ext.html) 05:07:35 INFO - PROCESS | 10363 | RSS: Main: 170598400 05:07:35 INFO - PROCESS | 10363 | 05:10:37 INFO - PROCESS | 10363 | Cycle 1(1): loaded http://localhost:34327/tests/dromaeo/cssquery-ext.html (next: http://localhost:34327/tests/dromaeo/cssquery-jquery.html) 05:10:38 INFO - PROCESS | 10363 | RSS: Main: 169271296 05:10:38 INFO - PROCESS | 10363 | 05:13:40 INFO - PROCESS | 10363 | Cycle 1(1): loaded http://localhost:34327/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34327/tests/dromaeo/cssquery-mootools.html) 05:13:40 INFO - PROCESS | 10363 | RSS: Main: 172716032 05:13:40 INFO - PROCESS | 10363 | 05:16:42 INFO - PROCESS | 10363 | Cycle 1(1): loaded http://localhost:34327/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34327/tests/dromaeo/cssquery-prototype.html) 05:16:43 INFO - PROCESS | 10363 | RSS: Main: 167780352 05:16:43 INFO - PROCESS | 10363 | 05:19:45 INFO - PROCESS | 10363 | Cycle 1(1): loaded http://localhost:34327/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34327/tests/dromaeo/cssquery-yui.html) 05:19:46 INFO - PROCESS | 10363 | RSS: Main: 169787392 05:19:46 INFO - PROCESS | 10363 | 05:22:49 INFO - PROCESS | 10363 | Cycle 1(1): loaded http://localhost:34327/tests/dromaeo/cssquery-yui.html (next: http://localhost:34327/tests/dromaeo/cssquery-dojo.html) 05:22:49 INFO - PROCESS | 10363 | RSS: Main: 170881024 05:22:49 INFO - PROCESS | 10363 | 05:22:49 INFO - PROCESS | 10363 | __start_tp_report 05:22:49 INFO - PROCESS | 10363 | _x_x_mozilla_page_load 05:22:49 INFO - PROCESS | 10363 | _x_x_mozilla_page_load_details 05:22:49 INFO - PROCESS | 10363 | |i|pagename|runs| 05:22:49 INFO - PROCESS | 10363 | |0;dojo.html;2607.243899269212;2677;2682.919512414627;2692.501887150876;2694.865256737163;4759.857204283872;4794.232922732359;4830.516948305168;4863.951360486394;4887.3890763654545;4699.506551812054;4841.7337046462435;4880.78036488358;4903.877403064926;4912.828051018215;4385.276429389147;4417.050334178151;4485.035717320776;4513.571210734975;4521.434820647419;4220.936685949713;4535.818567257323;4549.226631472658;4613.446386433616;4627.167109920213;4377.846775362847;4388.736675799462;4420.469543654782;4430.357598148283;4431.26884064129;4340.110277393127;4359.062801497693;4407.206702793496;4423.5797599228345;4437.0682156747125;4365.279728844736;4395.164918665443;4402.25161722508;4441.911161776747;4452;4789.137955168068;4879.316895634579;4881.8779530511665;4892.412910450733;4914.434839993375;5214;5226.5818734501145;5230.163173892197;5236.083685355047;5287.709175995319;5080.669756465855;5185.6888586684545;5264.15773476242;5267.841964741064;5275.868103297448;4838.225883858601;4839.370881785346;4856.053069651384;4887.65786394956;4912.042151780404;5336.386315573759;5336.946630533723;5339.519443250048;5347.598930080182;5380.7309634518115;5002.52476014778;5075.111855425286;5094.286799848024;5109.821156259513;5121.692698438105;4991.775370108354;5217.843464696065;5221.13851214553;5236.266922630834;5261.500157485033;5069.822556210589;5096.464871188546;5137.203733421251;5150.665206761549;5169.121249387538;5017.422996355466;5023.296738456619;5065.974670126626;5122.769475373617;5131.281620573122;4348.456442944632;4372.4315838941375;4384.4081049058605;4391.780410979502;4400.273954797487;3787.4129509926006;3803.82882770276;3813.142043040349;3818.9045273868373;3891.1633998690418;4342.69601127918;4397.450318710161;4413.271810151289;4419.248727716296;4434.423524941737;5180.585553155738;5186.247994040843;5187.896242075138;5231.136862417735;5250.65870718402;4442.244818380883;4445.555444455528;4445.911081778411;4449.399331090326;4496.887577810581;4591.219492686251;4662.090892276042;4681.906361872743;4683.953160468352;4685.320628508847;4841.007593443335;4854.660173787801;4858.58702010333;4879.34128892595;4914.483979182278;5069;5204.34945631796;5214.8957020860125;5218.947810521846;5239.187925871496;4872.756362181947;4884.5603895649565;4902.5587697106;4906.852794416173;4907.165781817171;5165.819196328261;5179.45615710345;5182.481751824787;5196.064708352533;5249.973750131225;5098.082345177903;5122.334096567422;5247.632665713363;5267.657602255841;5268.2361057647195;4902.730349830794;4950.8762280943265;5027.095122877917;5047.6214283929585;5073.518015788494;5092.668976516515;5105.132127538402;5114.897702045864;5126.384833819965;5168.147255702767;4875.512448755097;4965.553100220997;4972.801087956441;4999.200127979506;5006.974965125151;5062.924056139087;5070.340855688737;5080.441151473409;5106.336176297058;5113.130767769414;4966.106100901872;4981.676191047571;4997.525235102659;5016.874578135576;5034.84895453137 05:22:49 INFO - PROCESS | 10363 | |1;ext.html;563.0683915170671;578.8900108979294;585.1427658480326;595.074658905402;607.1378642327894;28445.573316400245;40415.19169616606;40925.18149637005;41142.794286028606;41181.794091029544;41143.794281028626;41264.58735412645;41620.58379416213;41692.166156676925;41767;8087.797805054876;8208;8213.301869341114;8217.917820821805;8232.423730338878;8003.51978881266;8142.389320800934;8153.980752405949;8162.061362943278;8166.550839703814;8106;8107.310878575328;8155.306798922099;8161.224683655043;8167.305779008791;8150.103488616248;8160.755177344659;8169.223923727236;8170.877436838452;8189.426740128193;8014.599270036533;8091.474054186459;8093.919060809375;8096.554689492075;8098.149694282133;40990.38514422286;41052.38421423681;41063.17873642511;41153.79423102895;41206.58793412057;2936.9118926432243;3154.7318477929402;3196.328770958102;3402.268512269874;3692.1877187018813;30066.84966575175;30399.24001899948;30594.84702576495;30611.540826887616;30892.073237802902;3377.881774137918;3434.4676575130893;3461.7671601816937;3469;3470.7570470067108;260838;261367;261632.9999999981;261779;261801;55616.16575751286;55676.16485752717;56081;56122.43877561172;56229;34091.2499625041;34830.47754283688;34835;36732;36770.632293677256;13626.182429054288;13760.93119534396;13805.654858628413;13811.964102692338;13845.16928984264;10769.892301077045;10770.192235582206;10770.461476926122;10787.460626968621;10835.349879007284;19066.33267835619;19124.617507649768;19158.233670653295;19186.424407267805;19207.51981200481;6916.273791251947;6950.756723514653;6993.790186294419;7180.210176880539;7247.275272472816;815.5636734347096;892.5001998880648;908.1275934123576;948.9952550237205;1022.1873610479538;28455.010174202274;29263;29305.56041659377;29355.412891742046;29820.40359192804;941.5715849288557;952.6284748947916;976.3409698453515;985.6008316631776;1009.5507499162949;15213;15577.766333505006;15715.68568628621;15763.211839407984;15771.526854194393;403597;406961;408994;409611;411409;50433.74783126061;50811.745941270055;51168.23247651288;51199.48800512022;51609;1176.6587689569928;1191.8986886114778;1200.609801814414;1203.8374819399444;1206.6922934651784;26405.471890562465;28403.573946391232;28971.420571588027;29022;29199.85400072986;44485;44646.3303050448;44679.32981005222;45108;45179.54820451754;350029;350262;350890;350955;351132;26129.73870261273;26474.735252648;26573.468530628892;26610;41925.580744192164;41942.370864436445;42217.78891105525;45924.770376147906;45962.31056534088;46146;38924;38940.35510861134;39455.60544394519;39529;40165.1966960665;38955.2208955825;38957.610423896534;39011.804940976246;39437;40261.798691006356;33723;36894;38633.227335453696;39061.609383906936;39148.80425597854;33903.830480847435;35294.11764705903;35569.46645800367;35590.64409355977;35811.64188358083;26769.19692409231;26796.196114116607;26970.865145674146;27097.522529221005;27198.592021120094 05:22:49 INFO - PROCESS | 10363 | |2;jquery.html;367.4635032852036;370.46837787774547;370.6571421435172;379.90587109125715;390.75577763897564;16385.590360240985;16622.16889155542;17688;17809.7328540072;17837.55406114848;15709.84290157098;15845.207739613032;16724.498265052036;16739.414120505786;16768.15550289467;5230.581553475713;5329.680219186842;5336.519713225809;5361.51746342829;5377.327834020747;5266.183741520052;5298.973505132469;5310.62825602208;5319.840404787863;5323.866903327409;5103.387593488768;5215.947840521603;5223.582113430935;5241.266222728821;5274.4198138204765;5197.428282888879;5236;5242.370915490146;5256.106461901467;5282.31329927107;4606.815727370901;4678.274867395559;4699.24812030077;4701.764911754432;4715.481297057321;21192.258270960596;21503.462413439633;21518.56962860734;21996.340109796733;22005.66991495129;1957.6476234277966;1989.413123128666;2020.9292674756314;2072.4093633314433;2137.5297434564372;13413.128146670435;13813.447462101503;14069.085509441957;14131;14214.644633884132;1693.5004173768768;1789.8389144976884;1811.5108920591367;1820.5630648644362;1820.881642693234;69423.30576694218;70033;70107.29892701059;70373.94439083469;71778.64110679414;9572.090651388107;9661.758456038655;9972.202223822076;10127.376795205846;10249.436281004617;13610.727785444236;13648.65878353049;13656.180629162282;13710.17738935667;13732.244726539937;6773.254941956381;6789.32106789327;6976.860462790716;7081.398081163159;7081.752138675121;6518;6543.738250469928;6551.1155993941165;6555.278919318871;6755.864882702417;6133.938660613337;6307.117003619497;6408.1349017881985;6430.421262086435;6470.935290647128;1774.7781527309087;1791.2834866053684;1837.6692195404687;1870.205162805802;1894.1855002349123;819.8975128108987;867.8823670244583;912.589334799343;929.6746138851348;964.2334344196381;17872;17943.73084403735;18063.909680451514;18365.88792288904;18624.72062919057;907;921.7373048681228;924.3806649544821;951.2770294576034;973.8393165127675;10036.447995360326;10390.272680912414;10393.688189354332;10450.529726162342;10500.422476763852;393577;393652;395676;403565;411886;69441;71565.2843471569;75270;76278;78712.21287787163;897.4301318662697;921.5115988526092;942.6559305853314;950.7005293332578;955.8757361543094;13005.804912926125;14575.781363279348;16630.833691662927;16678.66642667164;17144.22850971734;37650.81174594109;37979;39865.601343986185;40214.39678404885;40217.1956560873;52729;56065.719671401384;57132.714336429715;58050.41949580619;58108.709456452445;7271.200167981412;7282.963585182252;7360.705571777069;7550.697972081055;7642.426817988562;10217.1826253901;10325.535350909076;10775.353478791298;10916.50875710579;11122.555097795997;9418.717438476857;9886.901130988597;10028.849567256351;10086.747831304276;10228.335158214692;9465.290103242422;9504.619815207314;9906.25703072258;10046.346987445793;10102.747431313983;9628.807423851624;9939.701808945743;9940.155086817702;10012.499375031364;10100.949495252476;7195;7234.891476627749;7372.48392612512;7422.554646721214;7425.665845037094;9085.818283634158;9679.225661946886;9679.758006049906;10060.591517187453;10273.434961077213 05:22:49 INFO - PROCESS | 10363 | |3;mootools.html;1391.33216056293;1424.6865689548301;1519.1644595472487;1714.1771949464248;1721.4577408116443;7021.438284937206;7592.658330375132;7619.199984001683;8033.839323213532;8049.35605151588;7730.18833022533;7898.131205567383;7952.681892724298;7972.282494575487;7972.521648701082;2176.542925985541;2217.545403192342;2221.2669818959785;2231.1187081102953;2234.0393630738777;2090.644590419632;2131.7441906971185;2200.6368949123375;2206.5145667953107;2209.9226527071555;2151.8386121040908;2167.2631305356176;2169.5769324981634;2176.880271585062;2203.4160947348964;2157.7087093242367;2165.1988764157286;2165.566886622666;2165.902534385956;2169.327508472371;2108.399106254725;2132.76539580646;2134.8505604607685;2139.882306473143;2142.100317866484;7895.842083158304;7989.440739148262;8027.759167224993;8029.277365037116;8030.357571394275;4342.956570434287;4462.531434199427;4474.8433804817005;4483.708558943691;4486.967997360625;2857.414230082828;2895.5222388305906;2900.9274768130754;2935.1928219739743;2940.7794415418716;878.9296856251484;908.7818923458323;934.8270569944582;935.2517985611483;936.3398803843274;10866.348019118877;10900.563977440894;10941.28881622692;10974.615888443866;10997.61508347212;3970.662493688069;4134.400511925754;4182.53992060873;4207.326827707552;4258.1057977824385;9243.491607961627;9328.300377471716;9362.06379362072;9364.531773411301;9367.875854897457;4464.973056197028;4468.553144685506;4476.865694029184;4492.168948744427;4505.932411013838;3585.4263317869018;3907.902302442405;4033.838646454109;4112.691548133842;4145.66834653233;3612.133088058847;3669.633036696309;3755.6432138946757;3771.453139294787;3774.641409066134;1158.4671051316489;1174.0020982165263;1175.9353235571955;1176.9352685602203;1196.6230637349206;714.731975509184;822.0628483528782;823.798169448477;843.9113893041265;856.4304737349718;5107.106256405114;5153;5178.404483484373;5189.42916279209;5208.635395522353;388.67351424803303;390.78702107350995;393.15667892370703;393.1723721566119;402.81873157079434;3490.197254631449;3544.3620148373025;3761.492198553215;3810.7141964352786;3821.063839359375;9831;9985;10090.495475226357;10100.191984641211;10132.34139780912;9939.409694448854;10003.399796012263;10062.094411502854;10093.69718908434;10139.594416223268;7160.283971602798;7225.205227424979;7250.709971601183;7375.81560460982;7407.888816677541;5258.684478931276;5308.416074231909;5311.575073994149;5329.413764485826;5394.811181608782;8701.564921754014;8916.974547927071;8940.73177804667;9012.41419307743;9014.323925705467;8988.640454381752;8998.280137589109;9171.587278572346;9295.535223238947;9352.67265645699;6144.324124346408;6802.115724955724;6921.2732663069655;7041.5775053496955;7053.329933656294;7783;7794.298513133618;7799.844003119792;7875.330596899328;7880.84238315242;6832.624205668537;7003.929960700531;7005.2644472329675;7055.894161587683;7108.893366599402;6914.481413893877;6930.965345173242;6977.616231107135;7017.017617533447;7056.682449289691;5726.455986681259;5756.884862302814;5770.942290577041;5956.851078723066;5966.224390829165;4374.0814428969;4460.598546130864;4515.367848501278;4527.773611319487;4547.63618910493;4515.00942284454;4546.363509108794;4567.2007398705755;4686.390769199982;4692.225782745945 05:22:49 INFO - PROCESS | 10363 | |4;prototype.html;280.4153340285505;292.5582370620363;296.0644363810359;299.6000339546705;300.4486766782953;4983.9846892629985;4992.750362481879;5164.509371609701;5201.609879259061;5207.5052869977335;5024.472430394801;5046.21783623538;5072.365954255718;5076.695398276106;5084.288199652052;4033.798310084484;4040.151568170673;4053.331200351953;4058.472398588179;4080.510338759338;3944.4872166618297;4064.2277967186287;4067.491563554556;4070.8778736637946;4074.2258970795456;4004.339284018148;4004.5194576650842;4007.9198416031663;4009.8596549120784;4015.6586690131376;4000.739951903117;4025.2754504189234;4035.4148648445957;4042.9987156357643;4059.472268605092;3322.700956913865;3412.778169419005;3420.880269190591;3422.5892892853017;3598.7300952428673;4960.826371076995;4982.128127577659;5003.699778013331;5018.2974383586325;5031.723255220962;4478.350639157336;4494.348319493655;4507.5267096955;4516.525764794682;4528.615067719248;5275.28783614211;5332.573394128461;5376.811811586615;5394.595405344576;5396.244525766396;3750.081230098616;3766.5103536540073;3768.434734789776;3772;3772.1889793694213;5636.15457681347;5656.773729050833;5677.17680936262;5695.829125126253;5719;3718.2935242304416;3808.3716186829415;3811.847526098925;3824.043989002749;3847;3813.618638136164;3817.1411432428035;3826.693864490834;3831.1954489557506;3849.480320156743;4460.77696115193;4475.731456112644;4479.216137175981;4482.7534485602955;4503.797329120198;5178.326817513699;5397.865053373618;5415.756290966837;5425.701586412785;5429.755660995264;1301.2452777389092;1305.5169587252776;1309.7380523895258;1310.8033794930836;1312.6718320419895;821.8233079887733;840.4159109418895;856.2935578148052;856.5588721808274;856.6102423397339;4165.208610364021;4175;4185.937210941838;4249.68127390447;4274.914501709948;4935.136351138536;4981.9252711209365;4981.978694367646;5022.221555658879;5030.622703297194;4220.472440944882;4220.91558168841;4223.155368926227;4229;4250.872473825791;2450.7304196538366;2621.8033647476514;2622.4230669252734;2629.3426643339167;2632.5787873940076;4598.678092533491;4618.792154353062;4625.676202665848;4634.21218392874;4636.559526844944;4954.349423058647;4984.950150498521;5031.295618613397;5033.119204139261;5064.518870707277;4758.191107511662;5161.2516185152945;5177.948220517746;5220.034293655762;5224.910035985637;5592.3009623797025;5615.185798059177;5627.268455100811;5628.85927851807;5634.830955071355;5263.6841789492755;5457.836264912059;5517.834464966058;5518.365387980273;5521.309836270466;5187.273781670494;5195.818146364859;5199.194124910645;5215.027434362377;5226.11156103471;3610.1516143705685;3723.96276037247;3823.1589050408866;3829.8659546915724;3851.826667800012;5555.611107222456;5556.222128901876;5572.275604171432;5594;5600.663960162403;5286.392064912584;5407.188921661782;5427.3215848019;5437.619366644455;5444.50999410055;5349.518543331119;5350.30446042012;5360.534154289071;5361.839144825505;5414.75633596497;5238.790448382022;5276.683398996072;5325.174597937326;5327.280817089643;5343.278657381359;5210.114280572236;5394.379646340564;5398.784048638167;5414.187871819258;5425.674459532441;5210.348706411699;5240.659357141773;5268;5283.735813209401;5303.946960530346 05:22:49 INFO - PROCESS | 10363 | |5;yui.html;627.1909237084162;666.9666516674165;677.0185411885988;706.964297304449;734.6583838515089;12771.744565108693;13487.055906086578;13601.31993400331;13607.958806179078;13620.45518179273;12555.435005424755;12710.428030738616;12935.094543381967;12947.158434701738;12982.156159849603;782.1318336646318;801.7634797734653;802.0856223904754;804.6137853830165;804.6620419423856;794.1661255681511;794.5947566740975;795.026093036032;796.3947399976003;804.90341159061;835.9665613375488;837.6816809612369;839.1147339556766;841.0160112668162;842.8482873082843;824.8762685597148;826.1573195340779;827.4456114403364;827.93790465715;828.5277391886627;605.3280858247342;612.5681394616829;613.978510752126;614.8155553333982;616.3651439017818;12255.57105501312;12444;12445.439955202037;12450.750984980341;12469.625911222678;9983.251256155745;10081.647142350055;10653.946730266376;10697.679069627924;10955.726106847313;8983.281337492985;9087.954560227157;9198.586063627154;9255.259579233712;9460.195883349923;3040.300730831899;3043;3102.3640153768424;3107.347457034003;3149.9055028349185;52838.20742688824;54766.904661906934;59263.40736592622;59340.703296483676;59341;10336.844947325797;10362.689119326433;10437;10623.946880265548;10752.677419677266;17212;18601.627967440847;18617.348392806187;18726.157322920502;18729.157187926576;6484.708188131545;6725.764598239038;6730.394264516217;6740.966295168493;6961.79114626562;3744.4383342498845;3769.679577235911;3779.836230312345;3821.617838216156;3869.7484663496784;2867.641544806899;3129.937401252008;3250.1062207892546;3255.3326568053494;3304.9173770655443;555;575.3642225341022;579.4582065768436;581.2559923298185;585.2245774349004;543.1662398218715;581.6481028977407;585.280105470274;585.9824205273849;592.0793166625853;7604.5437273763755;7691.46159768822;7783.2216778322845;8009.959950200328;8061.604141521959;481.506455882716;531.702246741818;537.8063896997078;541.6533418612091;550.5017958747341;3566.6433356664643;3795.106074857062;3822.120912190212;3839.6928245740833;3896.201278737852;56986.430135698116;97742.5112874431;101519;104130;105921;65518.34481655122;69844.65077674681;70580;90893;91990.3203871851;72077;72454.63772681102;73423;74361;74548;8203.179682031749;8382.37132215074;8404.537750423786;8413.579321034047;8524.403291769764;41730.37404438875;42290.67401292959;42623.786881065396;42870.142597147256;44331;41298.58701412947;48719;54961;56095.43904560902;56679.43320566742;11239.494222759831;11406.657800266004;11466.140039496904;11484.425778711198;11495.540178393105;12443.191192572454;12764.489420423079;12987.545435909698;12995.870041299466;13396.330183490982;11433.371164585695;11704.239224450383;11941.104417168573;12021.519139234682;12245.387730613611;11206.215564910704;11668.766624667629;11984.460699268728;12357.567485137977;12631;11211.494069887674;11344.432778360884;11537.07703383744;11599.362035088152;11802.704932376415;9878.308518403643;10194.796104078025;10288.434136122585;10313.587456501957;10381.584736610452;9979.351342162736;10115.797684046425;10249.846252306072;10288.794224115625;10304.330218536072 05:22:49 INFO - PROCESS | 10363 | __end_tp_report 05:22:49 INFO - PROCESS | 10363 | __start_cc_report 05:22:49 INFO - PROCESS | 10363 | _x_x_mozilla_cycle_collect,381 05:22:49 INFO - PROCESS | 10363 | __end_cc_report 05:22:49 INFO - PROCESS | 10363 | __startTimestamp1467289369616__endTimestamp 05:22:49 INFO - PROCESS | 10363 | 05:22:49 INFO - PROCESS | 10363 | ------- Summary: start ------- 05:22:49 INFO - PROCESS | 10363 | Number of tests: 6 05:22:49 INFO - PROCESS | 10363 | 05:22:49 INFO - PROCESS | 10363 | [#0] dojo.html Cycles:165 Average:4787.47 Median:4907.17 stddev:515.97 (10.5%) stddev-sans-first:488.38 05:22:49 INFO - PROCESS | 10363 | Values: 2607.2 2677.0 2682.9 2692.5 2694.9 4759.9 4794.2 4830.5 4864.0 4887.4 4699.5 4841.7 4880.8 4903.9 4912.8 4385.3 4417.1 4485.0 4513.6 4521.4 4220.9 4535.8 4549.2 4613.4 4627.2 4377.8 4388.7 4420.5 4430.4 4431.3 4340.1 4359.1 4407.2 4423.6 4437.1 4365.3 4395.2 4402.3 4441.9 4452.0 4789.1 4879.3 4881.9 4892.4 4914.4 5214.0 5226.6 5230.2 5236.1 5287.7 5080.7 5185.7 5264.2 5267.8 5275.9 4838.2 4839.4 4856.1 4887.7 4912.0 5336.4 5336.9 5339.5 5347.6 5380.7 5002.5 5075.1 5094.3 5109.8 5121.7 4991.8 5217.8 5221.1 5236.3 5261.5 5069.8 5096.5 5137.2 5150.7 5169.1 5017.4 5023.3 5066.0 5122.8 5131.3 4348.5 4372.4 4384.4 4391.8 4400.3 3787.4 3803.8 3813.1 3818.9 3891.2 4342.7 4397.5 4413.3 4419.2 4434.4 5180.6 5186.2 5187.9 5231.1 5250.7 4442.2 4445.6 4445.9 4449.4 4496.9 4591.2 4662.1 4681.9 4684.0 4685.3 4841.0 4854.7 4858.6 4879.3 4914.5 5069.0 5204.3 5214.9 5218.9 5239.2 4872.8 4884.6 4902.6 4906.9 4907.2 5165.8 5179.5 5182.5 5196.1 5250.0 5098.1 5122.3 5247.6 5267.7 5268.2 4902.7 4950.9 5027.1 5047.6 5073.5 5092.7 5105.1 5114.9 5126.4 5168.1 4875.5 4965.6 4972.8 4999.2 5007.0 5062.9 5070.3 5080.4 5106.3 5113.1 4966.1 4981.7 4997.5 5016.9 5034.8 05:22:49 INFO - PROCESS | 10363 | 05:22:49 INFO - PROCESS | 10363 | [#1] ext.html Cycles:180 Average:49626.31 Median:39105.21 stddev:90996.49 (232.7%) stddev-sans-first:91177.20 05:22:49 INFO - PROCESS | 10363 | Values: 563.1 578.9 585.1 595.1 607.1 28445.6 40415.2 40925.2 41142.8 41181.8 41143.8 41264.6 41620.6 41692.2 41767.0 8087.8 8208.0 8213.3 8217.9 8232.4 8003.5 8142.4 8154.0 8162.1 8166.6 8106.0 8107.3 8155.3 8161.2 8167.3 8150.1 8160.8 8169.2 8170.9 8189.4 8014.6 8091.5 8093.9 8096.6 8098.1 40990.4 41052.4 41063.2 41153.8 41206.6 2936.9 3154.7 3196.3 3402.3 3692.2 30066.8 30399.2 30594.8 30611.5 30892.1 3377.9 3434.5 3461.8 3469.0 3470.8 260838.0 261367.0 261633.0 261779.0 261801.0 55616.2 55676.2 56081.0 56122.4 56229.0 34091.2 34830.5 34835.0 36732.0 36770.6 13626.2 13760.9 13805.7 13812.0 13845.2 10769.9 10770.2 10770.5 10787.5 10835.3 19066.3 19124.6 19158.2 19186.4 19207.5 6916.3 6950.8 6993.8 7180.2 7247.3 815.6 892.5 908.1 949.0 1022.2 28455.0 29263.0 29305.6 29355.4 29820.4 941.6 952.6 976.3 985.6 1009.6 15213.0 15577.8 15715.7 15763.2 15771.5 403597.0 406961.0 408994.0 409611.0 411409.0 50433.7 50811.7 51168.2 51199.5 51609.0 1176.7 1191.9 1200.6 1203.8 1206.7 26405.5 28403.6 28971.4 29022.0 29199.9 44485.0 44646.3 44679.3 45108.0 45179.5 350029.0 350262.0 350890.0 350955.0 351132.0 26129.7 26474.7 26573.5 26610.0 41925.6 41942.4 42217.8 45924.8 45962.3 46146.0 38924.0 38940.4 39455.6 39529.0 40165.2 38955.2 38957.6 39011.8 39437.0 40261.8 33723.0 36894.0 38633.2 39061.6 39148.8 33903.8 35294.1 35569.5 35590.6 35811.6 26769.2 26796.2 26970.9 27097.5 27198.6 05:22:49 INFO - PROCESS | 10363 | 05:22:49 INFO - PROCESS | 10363 | [#2] jquery.html Cycles:180 Average:24890.88 Median:4909.43 stddev:65962.75 (1343.6%) stddev-sans-first:66122.09 05:22:49 INFO - PROCESS | 10363 | Values: 367.5 370.5 370.7 379.9 390.8 16385.6 16622.2 17688.0 17809.7 17837.6 15709.8 15845.2 16724.5 16739.4 16768.2 5230.6 5329.7 5336.5 5361.5 5377.3 5266.2 5299.0 5310.6 5319.8 5323.9 5103.4 5215.9 5223.6 5241.3 5274.4 5197.4 5236.0 5242.4 5256.1 5282.3 4606.8 4678.3 4699.2 4701.8 4715.5 21192.3 21503.5 21518.6 21996.3 22005.7 1957.6 1989.4 2020.9 2072.4 2137.5 13413.1 13813.4 14069.1 14131.0 14214.6 1693.5 1789.8 1811.5 1820.6 1820.9 69423.3 70033.0 70107.3 70373.9 71778.6 9572.1 9661.8 9972.2 10127.4 10249.4 13610.7 13648.7 13656.2 13710.2 13732.2 6773.3 6789.3 6976.9 7081.4 7081.8 6518.0 6543.7 6551.1 6555.3 6755.9 6133.9 6307.1 6408.1 6430.4 6470.9 1774.8 1791.3 1837.7 1870.2 1894.2 819.9 867.9 912.6 929.7 964.2 17872.0 17943.7 18063.9 18365.9 18624.7 907.0 921.7 924.4 951.3 973.8 10036.4 10390.3 10393.7 10450.5 10500.4 393577.0 393652.0 395676.0 403565.0 411886.0 69441.0 71565.3 75270.0 76278.0 78712.2 897.4 921.5 942.7 950.7 955.9 13005.8 14575.8 16630.8 16678.7 17144.2 37650.8 37979.0 39865.6 40214.4 40217.2 52729.0 56065.7 57132.7 58050.4 58108.7 7271.2 7283.0 7360.7 7550.7 7642.4 10217.2 10325.5 10775.4 10916.5 11122.6 9418.7 9886.9 10028.8 10086.7 10228.3 9465.3 9504.6 9906.3 10046.3 10102.7 9628.8 9939.7 9940.2 10012.5 10100.9 7195.0 7234.9 7372.5 7422.6 7425.7 9085.8 9679.2 9679.8 10060.6 10273.4 05:22:49 INFO - PROCESS | 10363 | 05:22:49 INFO - PROCESS | 10363 | [#3] mootools.html Cycles:180 Average:5176.04 Median:4521.57 stddev:2984.86 (66.0%) stddev-sans-first:2979.68 05:22:49 INFO - PROCESS | 10363 | Values: 1391.3 1424.7 1519.2 1714.2 1721.5 7021.4 7592.7 7619.2 8033.8 8049.4 7730.2 7898.1 7952.7 7972.3 7972.5 2176.5 2217.5 2221.3 2231.1 2234.0 2090.6 2131.7 2200.6 2206.5 2209.9 2151.8 2167.3 2169.6 2176.9 2203.4 2157.7 2165.2 2165.6 2165.9 2169.3 2108.4 2132.8 2134.9 2139.9 2142.1 7895.8 7989.4 8027.8 8029.3 8030.4 4343.0 4462.5 4474.8 4483.7 4487.0 2857.4 2895.5 2900.9 2935.2 2940.8 878.9 908.8 934.8 935.3 936.3 10866.3 10900.6 10941.3 10974.6 10997.6 3970.7 4134.4 4182.5 4207.3 4258.1 9243.5 9328.3 9362.1 9364.5 9367.9 4465.0 4468.6 4476.9 4492.2 4505.9 3585.4 3907.9 4033.8 4112.7 4145.7 3612.1 3669.6 3755.6 3771.5 3774.6 1158.5 1174.0 1175.9 1176.9 1196.6 714.7 822.1 823.8 843.9 856.4 5107.1 5153.0 5178.4 5189.4 5208.6 388.7 390.8 393.2 393.2 402.8 3490.2 3544.4 3761.5 3810.7 3821.1 9831.0 9985.0 10090.5 10100.2 10132.3 9939.4 10003.4 10062.1 10093.7 10139.6 7160.3 7225.2 7250.7 7375.8 7407.9 5258.7 5308.4 5311.6 5329.4 5394.8 8701.6 8917.0 8940.7 9012.4 9014.3 8988.6 8998.3 9171.6 9295.5 9352.7 6144.3 6802.1 6921.3 7041.6 7053.3 7783.0 7794.3 7799.8 7875.3 7880.8 6832.6 7003.9 7005.3 7055.9 7108.9 6914.5 6931.0 6977.6 7017.0 7056.7 5726.5 5756.9 5770.9 5956.9 5966.2 4374.1 4460.6 4515.4 4527.8 4547.6 4515.0 4546.4 4567.2 4686.4 4692.2 05:22:49 INFO - PROCESS | 10363 | 05:22:49 INFO - PROCESS | 10363 | [#4] prototype.html Cycles:180 Average:4362.91 Median:4982.05 stddev:1300.41 (26.1%) stddev-sans-first:1267.44 05:22:49 INFO - PROCESS | 10363 | Values: 280.4 292.6 296.1 299.6 300.4 4984.0 4992.8 5164.5 5201.6 5207.5 5024.5 5046.2 5072.4 5076.7 5084.3 4033.8 4040.2 4053.3 4058.5 4080.5 3944.5 4064.2 4067.5 4070.9 4074.2 4004.3 4004.5 4007.9 4009.9 4015.7 4000.7 4025.3 4035.4 4043.0 4059.5 3322.7 3412.8 3420.9 3422.6 3598.7 4960.8 4982.1 5003.7 5018.3 5031.7 4478.4 4494.3 4507.5 4516.5 4528.6 5275.3 5332.6 5376.8 5394.6 5396.2 3750.1 3766.5 3768.4 3772.0 3772.2 5636.2 5656.8 5677.2 5695.8 5719.0 3718.3 3808.4 3811.8 3824.0 3847.0 3813.6 3817.1 3826.7 3831.2 3849.5 4460.8 4475.7 4479.2 4482.8 4503.8 5178.3 5397.9 5415.8 5425.7 5429.8 1301.2 1305.5 1309.7 1310.8 1312.7 821.8 840.4 856.3 856.6 856.6 4165.2 4175.0 4185.9 4249.7 4274.9 4935.1 4981.9 4982.0 5022.2 5030.6 4220.5 4220.9 4223.2 4229.0 4250.9 2450.7 2621.8 2622.4 2629.3 2632.6 4598.7 4618.8 4625.7 4634.2 4636.6 4954.3 4985.0 5031.3 5033.1 5064.5 4758.2 5161.3 5177.9 5220.0 5224.9 5592.3 5615.2 5627.3 5628.9 5634.8 5263.7 5457.8 5517.8 5518.4 5521.3 5187.3 5195.8 5199.2 5215.0 5226.1 3610.2 3724.0 3823.2 3829.9 3851.8 5555.6 5556.2 5572.3 5594.0 5600.7 5286.4 5407.2 5427.3 5437.6 5444.5 5349.5 5350.3 5360.5 5361.8 5414.8 5238.8 5276.7 5325.2 5327.3 5343.3 5210.1 5394.4 5398.8 5414.2 5425.7 5210.3 5240.7 5268.0 5283.7 5303.9 05:22:49 INFO - PROCESS | 10363 | 05:22:49 INFO - PROCESS | 10363 | [#5] yui.html Cycles:180 Average:16836.76 Median:22406.25 stddev:23913.88 (106.7%) stddev-sans-first:23950.00 05:22:49 INFO - PROCESS | 10363 | Values: 627.2 667.0 677.0 707.0 734.7 12771.7 13487.1 13601.3 13608.0 13620.5 12555.4 12710.4 12935.1 12947.2 12982.2 782.1 801.8 802.1 804.6 804.7 794.2 794.6 795.0 796.4 804.9 836.0 837.7 839.1 841.0 842.8 824.9 826.2 827.4 827.9 828.5 605.3 612.6 614.0 614.8 616.4 12255.6 12444.0 12445.4 12450.8 12469.6 9983.3 10081.6 10653.9 10697.7 10955.7 8983.3 9088.0 9198.6 9255.3 9460.2 3040.3 3043.0 3102.4 3107.3 3149.9 52838.2 54766.9 59263.4 59340.7 59341.0 10336.8 10362.7 10437.0 10623.9 10752.7 17212.0 18601.6 18617.3 18726.2 18729.2 6484.7 6725.8 6730.4 6741.0 6961.8 3744.4 3769.7 3779.8 3821.6 3869.7 2867.6 3129.9 3250.1 3255.3 3304.9 555.0 575.4 579.5 581.3 585.2 543.2 581.6 585.3 586.0 592.1 7604.5 7691.5 7783.2 8010.0 8061.6 481.5 531.7 537.8 541.7 550.5 3566.6 3795.1 3822.1 3839.7 3896.2 56986.4 97742.5 101519.0 104130.0 105921.0 65518.3 69844.7 70580.0 90893.0 91990.3 72077.0 72454.6 73423.0 74361.0 74548.0 8203.2 8382.4 8404.5 8413.6 8524.4 41730.4 42290.7 42623.8 42870.1 44331.0 41298.6 48719.0 54961.0 56095.4 56679.4 11239.5 11406.7 11466.1 11484.4 11495.5 12443.2 12764.5 12987.5 12995.9 13396.3 11433.4 11704.2 11941.1 12021.5 12245.4 11206.2 11668.8 11984.5 12357.6 12631.0 11211.5 11344.4 11537.1 11599.4 11802.7 9878.3 10194.8 10288.4 10313.6 10381.6 9979.4 10115.8 10249.8 10288.8 10304.3 05:22:49 INFO - PROCESS | 10363 | -------- Summary: end -------- 05:22:49 INFO - PROCESS | 10363 | 05:22:50 INFO - TEST-INFO | 10363: exit 0 05:22:50 INFO - TEST-OK | dromaeo_css | took 1116113ms 05:22:50 INFO - TEST-START | kraken 05:22:50 INFO - operating with platform_type : linux_ 05:22:50 INFO - Initialising browser for kraken test... 05:22:50 INFO - TEST-INFO | started process 10602 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC9IelF/profile http://localhost:34327/getInfo.html) 05:22:55 INFO - PROCESS | 10602 | __metrics Screen width/height:1600/1200 05:22:55 INFO - PROCESS | 10602 | colorDepth:24 05:22:55 INFO - PROCESS | 10602 | Browser inner width/height: 1024/697 05:22:55 INFO - PROCESS | 10602 | __metrics 05:22:56 ERROR - PROCESS | 10602 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 05:22:57 INFO - TEST-INFO | 10602: exit 0 05:22:57 INFO - Browser initialized. 05:22:57 INFO - Running cycle 1/1 for kraken test... 05:22:57 INFO - TEST-INFO | started process 10719 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC9IelF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:23:09 INFO - PROCESS | 10719 | RSS: Main: 169881600 05:23:09 INFO - PROCESS | 10719 | 05:23:11 INFO - PROCESS | 10719 | Cycle 1(1): loaded http://localhost:34327/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34327/tests/kraken/driver.html?testName=audio-beat-detection) 05:23:12 INFO - PROCESS | 10719 | RSS: Main: 174178304 05:23:12 INFO - PROCESS | 10719 | 05:23:15 INFO - PROCESS | 10719 | Cycle 1(1): loaded http://localhost:34327/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34327/tests/kraken/driver.html?testName=audio-dft) 05:23:16 INFO - PROCESS | 10719 | RSS: Main: 173957120 05:23:16 INFO - PROCESS | 10719 | 05:23:19 INFO - PROCESS | 10719 | Cycle 1(1): loaded http://localhost:34327/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34327/tests/kraken/driver.html?testName=audio-fft) 05:23:19 INFO - PROCESS | 10719 | RSS: Main: 169156608 05:23:19 INFO - PROCESS | 10719 | 05:23:21 INFO - PROCESS | 10719 | Cycle 1(1): loaded http://localhost:34327/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34327/tests/kraken/driver.html?testName=audio-oscillator) 05:23:22 INFO - PROCESS | 10719 | RSS: Main: 170192896 05:23:22 INFO - PROCESS | 10719 | 05:23:24 INFO - PROCESS | 10719 | Cycle 1(1): loaded http://localhost:34327/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34327/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:23:25 INFO - PROCESS | 10719 | RSS: Main: 170373120 05:23:25 INFO - PROCESS | 10719 | 05:23:28 INFO - PROCESS | 10719 | Cycle 1(1): loaded http://localhost:34327/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34327/tests/kraken/driver.html?testName=imaging-darkroom) 05:23:29 INFO - PROCESS | 10719 | RSS: Main: 170479616 05:23:29 INFO - PROCESS | 10719 | 05:23:32 INFO - PROCESS | 10719 | Cycle 1(1): loaded http://localhost:34327/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34327/tests/kraken/driver.html?testName=imaging-desaturate) 05:23:33 INFO - PROCESS | 10719 | RSS: Main: 168255488 05:23:33 INFO - PROCESS | 10719 | 05:23:36 INFO - PROCESS | 10719 | Cycle 1(1): loaded http://localhost:34327/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34327/tests/kraken/driver.html?testName=json-parse-financial) 05:23:37 INFO - PROCESS | 10719 | RSS: Main: 169283584 05:23:37 INFO - PROCESS | 10719 | 05:23:38 INFO - PROCESS | 10719 | Cycle 1(1): loaded http://localhost:34327/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34327/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:23:39 INFO - PROCESS | 10719 | RSS: Main: 169955328 05:23:39 INFO - PROCESS | 10719 | 05:23:41 INFO - PROCESS | 10719 | Cycle 1(1): loaded http://localhost:34327/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34327/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:23:41 INFO - PROCESS | 10719 | RSS: Main: 170041344 05:23:41 INFO - PROCESS | 10719 | 05:23:44 INFO - PROCESS | 10719 | Cycle 1(1): loaded http://localhost:34327/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34327/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:23:44 INFO - PROCESS | 10719 | RSS: Main: 170242048 05:23:44 INFO - PROCESS | 10719 | 05:23:47 INFO - PROCESS | 10719 | Cycle 1(1): loaded http://localhost:34327/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34327/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:23:48 INFO - PROCESS | 10719 | RSS: Main: 170881024 05:23:48 INFO - PROCESS | 10719 | 05:23:51 INFO - PROCESS | 10719 | Cycle 1(1): loaded http://localhost:34327/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34327/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:23:51 INFO - PROCESS | 10719 | RSS: Main: 170467328 05:23:51 INFO - PROCESS | 10719 | 05:23:53 INFO - PROCESS | 10719 | Cycle 1(1): loaded http://localhost:34327/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34327/tests/kraken/driver.html?testName=ai-astar) 05:23:53 INFO - PROCESS | 10719 | RSS: Main: 171585536 05:23:53 INFO - PROCESS | 10719 | 05:23:53 INFO - PROCESS | 10719 | __start_tp_report 05:23:53 INFO - PROCESS | 10719 | _x_x_mozilla_page_load 05:23:53 INFO - PROCESS | 10719 | _x_x_mozilla_page_load_details 05:23:53 INFO - PROCESS | 10719 | |i|pagename|runs| 05:23:53 INFO - PROCESS | 10719 | |0;ai-astar;106;118;110;115;115;116;118;115;114;114 05:23:53 INFO - PROCESS | 10719 | |1;audio-beat-detection;147;124;150;181;125;153;156;140;174;123 05:23:53 INFO - PROCESS | 10719 | |2;audio-dft;164;166;165;167;168;164;164;163;165;164 05:23:53 INFO - PROCESS | 10719 | |3;audio-fft;77;76;75;158;82;77;77;76;155;75 05:23:53 INFO - PROCESS | 10719 | |4;audio-oscillator;84;83;131;86;85;86;137;84;85;137 05:23:53 INFO - PROCESS | 10719 | |5;imaging-gaussian-blur;118;118;117;117;118;118;118;117;118;118 05:23:53 INFO - PROCESS | 10719 | |6;imaging-darkroom;148;148;147;149;148;148;148;147;148;149 05:23:53 INFO - PROCESS | 10719 | |7;imaging-desaturate;95;95;97;95;95;95;96;95;96;95 05:23:53 INFO - PROCESS | 10719 | |8;json-parse-financial;63;65;69;65;68;65;69;65;65;65 05:23:53 INFO - PROCESS | 10719 | |9;json-stringify-tinderbox;66;65;65;65;66;64;64;65;65;65 05:23:53 INFO - PROCESS | 10719 | |10;stanford-crypto-aes;78;86;79;79;79;79;80;80;83;79 05:23:53 INFO - PROCESS | 10719 | |11;stanford-crypto-ccm;153;141;129;137;142;136;132;131;180;131 05:23:53 INFO - PROCESS | 10719 | |12;stanford-crypto-pbkdf2;178;170;179;171;173;172;167;165;169;166 05:23:53 INFO - PROCESS | 10719 | |13;stanford-crypto-sha256-iterative;71;69;71;67;68;67;67;68;69;67 05:23:53 INFO - PROCESS | 10719 | __end_tp_report 05:23:53 INFO - PROCESS | 10719 | __start_cc_report 05:23:53 INFO - PROCESS | 10719 | _x_x_mozilla_cycle_collect,951 05:23:53 INFO - PROCESS | 10719 | __end_cc_report 05:23:53 INFO - PROCESS | 10719 | __startTimestamp1467289433722__endTimestamp 05:23:53 INFO - PROCESS | 10719 | 05:23:53 INFO - PROCESS | 10719 | ------- Summary: start ------- 05:23:53 INFO - PROCESS | 10719 | Number of tests: 14 05:23:53 INFO - PROCESS | 10719 | 05:23:53 INFO - PROCESS | 10719 | [#0] ai-astar Cycles:10 Average:114.10 Median:115.00 stddev:3.63 (3.2%) stddev-sans-first:2.40 05:23:53 INFO - PROCESS | 10719 | Values: 106.0 118.0 110.0 115.0 115.0 116.0 118.0 115.0 114.0 114.0 05:23:53 INFO - PROCESS | 10719 | 05:23:53 INFO - PROCESS | 10719 | [#1] audio-beat-detection Cycles:10 Average:147.30 Median:151.50 stddev:20.13 (13.3%) stddev-sans-first:21.35 05:23:53 INFO - PROCESS | 10719 | Values: 147.0 124.0 150.0 181.0 125.0 153.0 156.0 140.0 174.0 123.0 05:23:53 INFO - PROCESS | 10719 | 05:23:53 INFO - PROCESS | 10719 | [#2] audio-dft Cycles:10 Average:165.00 Median:165.00 stddev:1.56 (0.9%) stddev-sans-first:1.62 05:23:53 INFO - PROCESS | 10719 | Values: 164.0 166.0 165.0 167.0 168.0 164.0 164.0 163.0 165.0 164.0 05:23:53 INFO - PROCESS | 10719 | 05:23:53 INFO - PROCESS | 10719 | [#3] audio-fft Cycles:10 Average:92.80 Median:76.50 stddev:33.64 (44.0%) stddev-sans-first:35.19 05:23:53 INFO - PROCESS | 10719 | Values: 77.0 76.0 75.0 158.0 82.0 77.0 77.0 76.0 155.0 75.0 05:23:53 INFO - PROCESS | 10719 | 05:23:53 INFO - PROCESS | 10719 | [#4] audio-oscillator Cycles:10 Average:99.80 Median:84.50 stddev:24.36 (28.8%) stddev-sans-first:25.16 05:23:53 INFO - PROCESS | 10719 | Values: 84.0 83.0 131.0 86.0 85.0 86.0 137.0 84.0 85.0 137.0 05:23:53 INFO - PROCESS | 10719 | 05:23:53 INFO - PROCESS | 10719 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 05:23:53 INFO - PROCESS | 10719 | Values: 118.0 118.0 117.0 117.0 118.0 118.0 118.0 117.0 118.0 118.0 05:23:53 INFO - PROCESS | 10719 | 05:23:53 INFO - PROCESS | 10719 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 05:23:53 INFO - PROCESS | 10719 | Values: 148.0 148.0 147.0 149.0 148.0 148.0 148.0 147.0 148.0 149.0 05:23:53 INFO - PROCESS | 10719 | 05:23:53 INFO - PROCESS | 10719 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 05:23:53 INFO - PROCESS | 10719 | Values: 95.0 95.0 97.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 05:23:53 INFO - PROCESS | 10719 | 05:23:53 INFO - PROCESS | 10719 | [#8] json-parse-financial Cycles:10 Average:65.90 Median:65.00 stddev:2.02 (3.1%) stddev-sans-first:1.86 05:23:53 INFO - PROCESS | 10719 | Values: 63.0 65.0 69.0 65.0 68.0 65.0 69.0 65.0 65.0 65.0 05:23:53 INFO - PROCESS | 10719 | 05:23:53 INFO - PROCESS | 10719 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 05:23:53 INFO - PROCESS | 10719 | Values: 66.0 65.0 65.0 65.0 66.0 64.0 64.0 65.0 65.0 65.0 05:23:53 INFO - PROCESS | 10719 | 05:23:53 INFO - PROCESS | 10719 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:79.50 stddev:2.44 (3.1%) stddev-sans-first:2.46 05:23:53 INFO - PROCESS | 10719 | Values: 78.0 86.0 79.0 79.0 79.0 79.0 80.0 80.0 83.0 79.0 05:23:53 INFO - PROCESS | 10719 | 05:23:53 INFO - PROCESS | 10719 | [#11] stanford-crypto-ccm Cycles:10 Average:141.20 Median:139.00 stddev:15.39 (11.1%) stddev-sans-first:15.72 05:23:53 INFO - PROCESS | 10719 | Values: 153.0 141.0 129.0 137.0 142.0 136.0 132.0 131.0 180.0 131.0 05:23:53 INFO - PROCESS | 10719 | 05:23:53 INFO - PROCESS | 10719 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.00 Median:171.50 stddev:4.71 (2.7%) stddev-sans-first:4.27 05:23:53 INFO - PROCESS | 10719 | Values: 178.0 170.0 179.0 171.0 173.0 172.0 167.0 165.0 169.0 166.0 05:23:53 INFO - PROCESS | 10719 | 05:23:53 INFO - PROCESS | 10719 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.50 stddev:1.58 (2.3%) stddev-sans-first:1.36 05:23:53 INFO - PROCESS | 10719 | Values: 71.0 69.0 71.0 67.0 68.0 67.0 67.0 68.0 69.0 67.0 05:23:53 INFO - PROCESS | 10719 | -------- Summary: end -------- 05:23:53 INFO - PROCESS | 10719 | 05:23:54 INFO - TEST-INFO | 10719: exit 0 05:23:54 INFO - TEST-OK | kraken | took 64424ms 05:23:54 INFO - SUITE-END | took 1180s 05:23:54 INFO - Completed test suite (00:19:40) 05:23:54 INFO - javascript benchmark 05:23:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6483.007307836477, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2607.243899269212, 2677.0, 2682.919512414627, 2692.501887150876, 2694.865256737163, 4759.857204283872, 4794.232922732359, 4830.516948305168, 4863.951360486394, 4887.3890763654545, 4699.506551812054, 4841.7337046462435, 4880.78036488358, 4903.877403064926, 4912.828051018215, 4385.276429389147, 4417.050334178151, 4485.035717320776, 4513.571210734975, 4521.434820647419, 4220.936685949713, 4535.818567257323, 4549.226631472658, 4613.446386433616, 4627.167109920213, 4377.846775362847, 4388.736675799462, 4420.469543654782, 4430.357598148283, 4431.26884064129, 4340.110277393127, 4359.062801497693, 4407.206702793496, 4423.5797599228345, 4437.0682156747125, 4365.279728844736, 4395.164918665443, 4402.25161722508, 4441.911161776747, 4452.0, 4789.137955168068, 4879.316895634579, 4881.8779530511665, 4892.412910450733, 4914.434839993375, 5214.0, 5226.5818734501145, 5230.163173892197, 5236.083685355047, 5287.709175995319, 5080.669756465855, 5185.6888586684545, 5264.15773476242, 5267.841964741064, 5275.868103297448, 4838.225883858601, 4839.370881785346, 4856.053069651384, 4887.65786394956, 4912.042151780404, 5336.386315573759, 5336.946630533723, 5339.519443250048, 5347.598930080182, 5380.7309634518115, 5002.52476014778, 5075.111855425286, 5094.286799848024, 5109.821156259513, 5121.692698438105, 4991.775370108354, 5217.843464696065, 5221.13851214553, 5236.266922630834, 5261.500157485033, 5069.822556210589, 5096.464871188546, 5137.203733421251, 5150.665206761549, 5169.121249387538, 5017.422996355466, 5023.296738456619, 5065.974670126626, 5122.769475373617, 5131.281620573122, 4348.456442944632, 4372.4315838941375, 4384.4081049058605, 4391.780410979502, 4400.273954797487, 3787.4129509926006, 3803.82882770276, 3813.142043040349, 3818.9045273868373, 3891.1633998690418, 4342.69601127918, 4397.450318710161, 4413.271810151289, 4419.248727716296, 4434.423524941737, 5180.585553155738, 5186.247994040843, 5187.896242075138, 5231.136862417735, 5250.65870718402, 4442.244818380883, 4445.555444455528, 4445.911081778411, 4449.399331090326, 4496.887577810581, 4591.219492686251, 4662.090892276042, 4681.906361872743, 4683.953160468352, 4685.320628508847, 4841.007593443335, 4854.660173787801, 4858.58702010333, 4879.34128892595, 4914.483979182278, 5069.0, 5204.34945631796, 5214.8957020860125, 5218.947810521846, 5239.187925871496, 4872.756362181947, 4884.5603895649565, 4902.5587697106, 4906.852794416173, 4907.165781817171, 5165.819196328261, 5179.45615710345, 5182.481751824787, 5196.064708352533, 5249.973750131225, 5098.082345177903, 5122.334096567422, 5247.632665713363, 5267.657602255841, 5268.2361057647195, 4902.730349830794, 4950.8762280943265, 5027.095122877917, 5047.6214283929585, 5073.518015788494, 5092.668976516515, 5105.132127538402, 5114.897702045864, 5126.384833819965, 5168.147255702767, 4875.512448755097, 4965.553100220997, 4972.801087956441, 4999.200127979506, 5006.974965125151, 5062.924056139087, 5070.340855688737, 5080.441151473409, 5106.336176297058, 5113.130767769414, 4966.106100901872, 4981.676191047571, 4997.525235102659, 5016.874578135576, 5034.84895453137], "value": 4753.594987556314, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.0683915170671, 578.8900108979294, 585.1427658480326, 595.074658905402, 607.1378642327894, 28445.573316400245, 40415.19169616606, 40925.18149637005, 41142.794286028606, 41181.794091029544, 41143.794281028626, 41264.58735412645, 41620.58379416213, 41692.166156676925, 41767.0, 8087.797805054876, 8208.0, 8213.301869341114, 8217.917820821805, 8232.423730338878, 8003.51978881266, 8142.389320800934, 8153.980752405949, 8162.061362943278, 8166.550839703814, 8106.0, 8107.310878575328, 8155.306798922099, 8161.224683655043, 8167.305779008791, 8150.103488616248, 8160.755177344659, 8169.223923727236, 8170.877436838452, 8189.426740128193, 8014.599270036533, 8091.474054186459, 8093.919060809375, 8096.554689492075, 8098.149694282133, 40990.38514422286, 41052.38421423681, 41063.17873642511, 41153.79423102895, 41206.58793412057, 2936.9118926432243, 3154.7318477929402, 3196.328770958102, 3402.268512269874, 3692.1877187018813, 30066.84966575175, 30399.24001899948, 30594.84702576495, 30611.540826887616, 30892.073237802902, 3377.881774137918, 3434.4676575130893, 3461.7671601816937, 3469.0, 3470.7570470067108, 260838.0, 261367.0, 261632.9999999981, 261779.0, 261801.0, 55616.16575751286, 55676.16485752717, 56081.0, 56122.43877561172, 56229.0, 34091.2499625041, 34830.47754283688, 34835.0, 36732.0, 36770.632293677256, 13626.182429054288, 13760.93119534396, 13805.654858628413, 13811.964102692338, 13845.16928984264, 10769.892301077045, 10770.192235582206, 10770.461476926122, 10787.460626968621, 10835.349879007284, 19066.33267835619, 19124.617507649768, 19158.233670653295, 19186.424407267805, 19207.51981200481, 6916.273791251947, 6950.756723514653, 6993.790186294419, 7180.210176880539, 7247.275272472816, 815.5636734347096, 892.5001998880648, 908.1275934123576, 948.9952550237205, 1022.1873610479538, 28455.010174202274, 29263.0, 29305.56041659377, 29355.412891742046, 29820.40359192804, 941.5715849288557, 952.6284748947916, 976.3409698453515, 985.6008316631776, 1009.5507499162949, 15213.0, 15577.766333505006, 15715.68568628621, 15763.211839407984, 15771.526854194393, 403597.0, 406961.0, 408994.0, 409611.0, 411409.0, 50433.74783126061, 50811.745941270055, 51168.23247651288, 51199.48800512022, 51609.0, 1176.6587689569928, 1191.8986886114778, 1200.609801814414, 1203.8374819399444, 1206.6922934651784, 26405.471890562465, 28403.573946391232, 28971.420571588027, 29022.0, 29199.85400072986, 44485.0, 44646.3303050448, 44679.32981005222, 45108.0, 45179.54820451754, 350029.0, 350262.0, 350890.0, 350955.0, 351132.0, 26129.73870261273, 26474.735252648, 26573.468530628892, 26610.0, 41925.580744192164, 41942.370864436445, 42217.78891105525, 45924.770376147906, 45962.31056534088, 46146.0, 38924.0, 38940.35510861134, 39455.60544394519, 39529.0, 40165.1966960665, 38955.2208955825, 38957.610423896534, 39011.804940976246, 39437.0, 40261.798691006356, 33723.0, 36894.0, 38633.227335453696, 39061.609383906936, 39148.80425597854, 33903.830480847435, 35294.11764705903, 35569.46645800367, 35590.64409355977, 35811.64188358083, 26769.19692409231, 26796.196114116607, 26970.865145674146, 27097.522529221005, 27198.592021120094], "value": 18023.440890839654, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.4635032852036, 370.46837787774547, 370.6571421435172, 379.90587109125715, 390.75577763897564, 16385.590360240985, 16622.16889155542, 17688.0, 17809.7328540072, 17837.55406114848, 15709.84290157098, 15845.207739613032, 16724.498265052036, 16739.414120505786, 16768.15550289467, 5230.581553475713, 5329.680219186842, 5336.519713225809, 5361.51746342829, 5377.327834020747, 5266.183741520052, 5298.973505132469, 5310.62825602208, 5319.840404787863, 5323.866903327409, 5103.387593488768, 5215.947840521603, 5223.582113430935, 5241.266222728821, 5274.4198138204765, 5197.428282888879, 5236.0, 5242.370915490146, 5256.106461901467, 5282.31329927107, 4606.815727370901, 4678.274867395559, 4699.24812030077, 4701.764911754432, 4715.481297057321, 21192.258270960596, 21503.462413439633, 21518.56962860734, 21996.340109796733, 22005.66991495129, 1957.6476234277966, 1989.413123128666, 2020.9292674756314, 2072.4093633314433, 2137.5297434564372, 13413.128146670435, 13813.447462101503, 14069.085509441957, 14131.0, 14214.644633884132, 1693.5004173768768, 1789.8389144976884, 1811.5108920591367, 1820.5630648644362, 1820.881642693234, 69423.30576694218, 70033.0, 70107.29892701059, 70373.94439083469, 71778.64110679414, 9572.090651388107, 9661.758456038655, 9972.202223822076, 10127.376795205846, 10249.436281004617, 13610.727785444236, 13648.65878353049, 13656.180629162282, 13710.17738935667, 13732.244726539937, 6773.254941956381, 6789.32106789327, 6976.860462790716, 7081.398081163159, 7081.752138675121, 6518.0, 6543.738250469928, 6551.1155993941165, 6555.278919318871, 6755.864882702417, 6133.938660613337, 6307.117003619497, 6408.1349017881985, 6430.421262086435, 6470.935290647128, 1774.7781527309087, 1791.2834866053684, 1837.6692195404687, 1870.205162805802, 1894.1855002349123, 819.8975128108987, 867.8823670244583, 912.589334799343, 929.6746138851348, 964.2334344196381, 17872.0, 17943.73084403735, 18063.909680451514, 18365.88792288904, 18624.72062919057, 907.0, 921.7373048681228, 924.3806649544821, 951.2770294576034, 973.8393165127675, 10036.447995360326, 10390.272680912414, 10393.688189354332, 10450.529726162342, 10500.422476763852, 393577.0, 393652.0, 395676.0, 403565.0, 411886.0, 69441.0, 71565.2843471569, 75270.0, 76278.0, 78712.21287787163, 897.4301318662697, 921.5115988526092, 942.6559305853314, 950.7005293332578, 955.8757361543094, 13005.804912926125, 14575.781363279348, 16630.833691662927, 16678.66642667164, 17144.22850971734, 37650.81174594109, 37979.0, 39865.601343986185, 40214.39678404885, 40217.1956560873, 52729.0, 56065.719671401384, 57132.714336429715, 58050.41949580619, 58108.709456452445, 7271.200167981412, 7282.963585182252, 7360.705571777069, 7550.697972081055, 7642.426817988562, 10217.1826253901, 10325.535350909076, 10775.353478791298, 10916.50875710579, 11122.555097795997, 9418.717438476857, 9886.901130988597, 10028.849567256351, 10086.747831304276, 10228.335158214692, 9465.290103242422, 9504.619815207314, 9906.25703072258, 10046.346987445793, 10102.747431313983, 9628.807423851624, 9939.701808945743, 9940.155086817702, 10012.499375031364, 10100.949495252476, 7195.0, 7234.891476627749, 7372.48392612512, 7422.554646721214, 7425.665845037094, 9085.818283634158, 9679.225661946886, 9679.758006049906, 10060.591517187453, 10273.434961077213], "value": 8387.137962864666, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1391.33216056293, 1424.6865689548301, 1519.1644595472487, 1714.1771949464248, 1721.4577408116443, 7021.438284937206, 7592.658330375132, 7619.199984001683, 8033.839323213532, 8049.35605151588, 7730.18833022533, 7898.131205567383, 7952.681892724298, 7972.282494575487, 7972.521648701082, 2176.542925985541, 2217.545403192342, 2221.2669818959785, 2231.1187081102953, 2234.0393630738777, 2090.644590419632, 2131.7441906971185, 2200.6368949123375, 2206.5145667953107, 2209.9226527071555, 2151.8386121040908, 2167.2631305356176, 2169.5769324981634, 2176.880271585062, 2203.4160947348964, 2157.7087093242367, 2165.1988764157286, 2165.566886622666, 2165.902534385956, 2169.327508472371, 2108.399106254725, 2132.76539580646, 2134.8505604607685, 2139.882306473143, 2142.100317866484, 7895.842083158304, 7989.440739148262, 8027.759167224993, 8029.277365037116, 8030.357571394275, 4342.956570434287, 4462.531434199427, 4474.8433804817005, 4483.708558943691, 4486.967997360625, 2857.414230082828, 2895.5222388305906, 2900.9274768130754, 2935.1928219739743, 2940.7794415418716, 878.9296856251484, 908.7818923458323, 934.8270569944582, 935.2517985611483, 936.3398803843274, 10866.348019118877, 10900.563977440894, 10941.28881622692, 10974.615888443866, 10997.61508347212, 3970.662493688069, 4134.400511925754, 4182.53992060873, 4207.326827707552, 4258.1057977824385, 9243.491607961627, 9328.300377471716, 9362.06379362072, 9364.531773411301, 9367.875854897457, 4464.973056197028, 4468.553144685506, 4476.865694029184, 4492.168948744427, 4505.932411013838, 3585.4263317869018, 3907.902302442405, 4033.838646454109, 4112.691548133842, 4145.66834653233, 3612.133088058847, 3669.633036696309, 3755.6432138946757, 3771.453139294787, 3774.641409066134, 1158.4671051316489, 1174.0020982165263, 1175.9353235571955, 1176.9352685602203, 1196.6230637349206, 714.731975509184, 822.0628483528782, 823.798169448477, 843.9113893041265, 856.4304737349718, 5107.106256405114, 5153.0, 5178.404483484373, 5189.42916279209, 5208.635395522353, 388.67351424803303, 390.78702107350995, 393.15667892370703, 393.1723721566119, 402.81873157079434, 3490.197254631449, 3544.3620148373025, 3761.492198553215, 3810.7141964352786, 3821.063839359375, 9831.0, 9985.0, 10090.495475226357, 10100.191984641211, 10132.34139780912, 9939.409694448854, 10003.399796012263, 10062.094411502854, 10093.69718908434, 10139.594416223268, 7160.283971602798, 7225.205227424979, 7250.709971601183, 7375.81560460982, 7407.888816677541, 5258.684478931276, 5308.416074231909, 5311.575073994149, 5329.413764485826, 5394.811181608782, 8701.564921754014, 8916.974547927071, 8940.73177804667, 9012.41419307743, 9014.323925705467, 8988.640454381752, 8998.280137589109, 9171.587278572346, 9295.535223238947, 9352.67265645699, 6144.324124346408, 6802.115724955724, 6921.2732663069655, 7041.5775053496955, 7053.329933656294, 7783.0, 7794.298513133618, 7799.844003119792, 7875.330596899328, 7880.84238315242, 6832.624205668537, 7003.929960700531, 7005.2644472329675, 7055.894161587683, 7108.893366599402, 6914.481413893877, 6930.965345173242, 6977.616231107135, 7017.017617533447, 7056.682449289691, 5726.455986681259, 5756.884862302814, 5770.942290577041, 5956.851078723066, 5966.224390829165, 4374.0814428969, 4460.598546130864, 4515.367848501278, 4527.773611319487, 4547.63618910493, 4515.00942284454, 4546.363509108794, 4567.2007398705755, 4686.390769199982, 4692.225782745945], "value": 4067.7191490414257, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [280.4153340285505, 292.5582370620363, 296.0644363810359, 299.6000339546705, 300.4486766782953, 4983.9846892629985, 4992.750362481879, 5164.509371609701, 5201.609879259061, 5207.5052869977335, 5024.472430394801, 5046.21783623538, 5072.365954255718, 5076.695398276106, 5084.288199652052, 4033.798310084484, 4040.151568170673, 4053.331200351953, 4058.472398588179, 4080.510338759338, 3944.4872166618297, 4064.2277967186287, 4067.491563554556, 4070.8778736637946, 4074.2258970795456, 4004.339284018148, 4004.5194576650842, 4007.9198416031663, 4009.8596549120784, 4015.6586690131376, 4000.739951903117, 4025.2754504189234, 4035.4148648445957, 4042.9987156357643, 4059.472268605092, 3322.700956913865, 3412.778169419005, 3420.880269190591, 3422.5892892853017, 3598.7300952428673, 4960.826371076995, 4982.128127577659, 5003.699778013331, 5018.2974383586325, 5031.723255220962, 4478.350639157336, 4494.348319493655, 4507.5267096955, 4516.525764794682, 4528.615067719248, 5275.28783614211, 5332.573394128461, 5376.811811586615, 5394.595405344576, 5396.244525766396, 3750.081230098616, 3766.5103536540073, 3768.434734789776, 3772.0, 3772.1889793694213, 5636.15457681347, 5656.773729050833, 5677.17680936262, 5695.829125126253, 5719.0, 3718.2935242304416, 3808.3716186829415, 3811.847526098925, 3824.043989002749, 3847.0, 3813.618638136164, 3817.1411432428035, 3826.693864490834, 3831.1954489557506, 3849.480320156743, 4460.77696115193, 4475.731456112644, 4479.216137175981, 4482.7534485602955, 4503.797329120198, 5178.326817513699, 5397.865053373618, 5415.756290966837, 5425.701586412785, 5429.755660995264, 1301.2452777389092, 1305.5169587252776, 1309.7380523895258, 1310.8033794930836, 1312.6718320419895, 821.8233079887733, 840.4159109418895, 856.2935578148052, 856.5588721808274, 856.6102423397339, 4165.208610364021, 4175.0, 4185.937210941838, 4249.68127390447, 4274.914501709948, 4935.136351138536, 4981.9252711209365, 4981.978694367646, 5022.221555658879, 5030.622703297194, 4220.472440944882, 4220.91558168841, 4223.155368926227, 4229.0, 4250.872473825791, 2450.7304196538366, 2621.8033647476514, 2622.4230669252734, 2629.3426643339167, 2632.5787873940076, 4598.678092533491, 4618.792154353062, 4625.676202665848, 4634.21218392874, 4636.559526844944, 4954.349423058647, 4984.950150498521, 5031.295618613397, 5033.119204139261, 5064.518870707277, 4758.191107511662, 5161.2516185152945, 5177.948220517746, 5220.034293655762, 5224.910035985637, 5592.3009623797025, 5615.185798059177, 5627.268455100811, 5628.85927851807, 5634.830955071355, 5263.6841789492755, 5457.836264912059, 5517.834464966058, 5518.365387980273, 5521.309836270466, 5187.273781670494, 5195.818146364859, 5199.194124910645, 5215.027434362377, 5226.11156103471, 3610.1516143705685, 3723.96276037247, 3823.1589050408866, 3829.8659546915724, 3851.826667800012, 5555.611107222456, 5556.222128901876, 5572.275604171432, 5594.0, 5600.663960162403, 5286.392064912584, 5407.188921661782, 5427.3215848019, 5437.619366644455, 5444.50999410055, 5349.518543331119, 5350.30446042012, 5360.534154289071, 5361.839144825505, 5414.75633596497, 5238.790448382022, 5276.683398996072, 5325.174597937326, 5327.280817089643, 5343.278657381359, 5210.114280572236, 5394.379646340564, 5398.784048638167, 5414.187871819258, 5425.674459532441, 5210.348706411699, 5240.659357141773, 5268.0, 5283.735813209401, 5303.946960530346], "value": 3940.4544399726824, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [627.1909237084162, 666.9666516674165, 677.0185411885988, 706.964297304449, 734.6583838515089, 12771.744565108693, 13487.055906086578, 13601.31993400331, 13607.958806179078, 13620.45518179273, 12555.435005424755, 12710.428030738616, 12935.094543381967, 12947.158434701738, 12982.156159849603, 782.1318336646318, 801.7634797734653, 802.0856223904754, 804.6137853830165, 804.6620419423856, 794.1661255681511, 794.5947566740975, 795.026093036032, 796.3947399976003, 804.90341159061, 835.9665613375488, 837.6816809612369, 839.1147339556766, 841.0160112668162, 842.8482873082843, 824.8762685597148, 826.1573195340779, 827.4456114403364, 827.93790465715, 828.5277391886627, 605.3280858247342, 612.5681394616829, 613.978510752126, 614.8155553333982, 616.3651439017818, 12255.57105501312, 12444.0, 12445.439955202037, 12450.750984980341, 12469.625911222678, 9983.251256155745, 10081.647142350055, 10653.946730266376, 10697.679069627924, 10955.726106847313, 8983.281337492985, 9087.954560227157, 9198.586063627154, 9255.259579233712, 9460.195883349923, 3040.300730831899, 3043.0, 3102.3640153768424, 3107.347457034003, 3149.9055028349185, 52838.20742688824, 54766.904661906934, 59263.40736592622, 59340.703296483676, 59341.0, 10336.844947325797, 10362.689119326433, 10437.0, 10623.946880265548, 10752.677419677266, 17212.0, 18601.627967440847, 18617.348392806187, 18726.157322920502, 18729.157187926576, 6484.708188131545, 6725.764598239038, 6730.394264516217, 6740.966295168493, 6961.79114626562, 3744.4383342498845, 3769.679577235911, 3779.836230312345, 3821.617838216156, 3869.7484663496784, 2867.641544806899, 3129.937401252008, 3250.1062207892546, 3255.3326568053494, 3304.9173770655443, 555.0, 575.3642225341022, 579.4582065768436, 581.2559923298185, 585.2245774349004, 543.1662398218715, 581.6481028977407, 585.280105470274, 585.9824205273849, 592.0793166625853, 7604.5437273763755, 7691.46159768822, 7783.2216778322845, 8009.959950200328, 8061.604141521959, 481.506455882716, 531.702246741818, 537.8063896997078, 541.6533418612091, 550.5017958747341, 3566.6433356664643, 3795.106074857062, 3822.120912190212, 3839.6928245740833, 3896.201278737852, 56986.430135698116, 97742.5112874431, 101519.0, 104130.0, 105921.0, 65518.34481655122, 69844.65077674681, 70580.0, 90893.0, 91990.3203871851, 72077.0, 72454.63772681102, 73423.0, 74361.0, 74548.0, 8203.179682031749, 8382.37132215074, 8404.537750423786, 8413.579321034047, 8524.403291769764, 41730.37404438875, 42290.67401292959, 42623.786881065396, 42870.142597147256, 44331.0, 41298.58701412947, 48719.0, 54961.0, 56095.43904560902, 56679.43320566742, 11239.494222759831, 11406.657800266004, 11466.140039496904, 11484.425778711198, 11495.540178393105, 12443.191192572454, 12764.489420423079, 12987.545435909698, 12995.870041299466, 13396.330183490982, 11433.371164585695, 11704.239224450383, 11941.104417168573, 12021.519139234682, 12245.387730613611, 11206.215564910704, 11668.766624667629, 11984.460699268728, 12357.567485137977, 12631.0, 11211.494069887674, 11344.432778360884, 11537.07703383744, 11599.362035088152, 11802.704932376415, 9878.308518403643, 10194.796104078025, 10288.434136122585, 10313.587456501957, 10381.584736610452, 9979.351342162736, 10115.797684046425, 10249.846252306072, 10288.794224115625, 10304.330218536072], "value": 6445.2308631663245, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1571.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 118.0, 110.0, 115.0, 115.0, 116.0, 118.0, 115.0, 114.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 124.0, 150.0, 181.0, 125.0, 153.0, 156.0, 140.0, 174.0, 123.0], "value": 147.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 165.0, 167.0, 168.0, 164.0, 164.0, 163.0, 165.0, 164.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 75.0, 158.0, 82.0, 77.0, 77.0, 76.0, 155.0, 75.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 131.0, 86.0, 85.0, 86.0, 137.0, 84.0, 85.0, 137.0], "value": 99.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 117.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 149.0, 148.0, 148.0, 148.0, 147.0, 148.0, 149.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 69.0, 65.0, 68.0, 65.0, 69.0, 65.0, 65.0, 65.0], "value": 65.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 65.0, 66.0, 64.0, 64.0, 65.0, 65.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 86.0, 79.0, 79.0, 79.0, 79.0, 80.0, 80.0, 83.0, 79.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 141.0, 129.0, 137.0, 142.0, 136.0, 132.0, 131.0, 180.0, 131.0], "value": 141.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 170.0, 179.0, 171.0, 173.0, 172.0, 167.0, 165.0, 169.0, 166.0], "value": 171.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 71.0, 67.0, 68.0, 67.0, 67.0, 68.0, 69.0, 67.0], "value": 68.4, "unit": "score"}]}]} 05:23:54 INFO - Return code: 0 05:23:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:23:55 ERROR - # TBPL SUCCESS # 05:23:55 INFO - Running post-action listener: _resource_record_post_action 05:23:55 INFO - ##### 05:23:55 INFO - ##### Finished run-tests step (success) 05:23:55 INFO - ##### 05:23:55 INFO - Running post-run listener: _resource_record_post_run 05:23:55 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 86016; Write bytes: 538005504; Read time: 40; Write time: 575456 05:23:55 INFO - TinderboxPrint: CPU usage
13.4% 05:23:55 INFO - TinderboxPrint: I/O read bytes / time
86,016 / 40 05:23:55 INFO - TinderboxPrint: I/O write bytes / time
538,005,504 / 575,456 05:23:55 INFO - TinderboxPrint: CPU idle
8,274.4 (86.6%) 05:23:55 INFO - TinderboxPrint: CPU user
1,221.8 (12.8%) 05:23:55 INFO - TinderboxPrint: Swap in / out
0 / 0 05:23:55 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 245579776; Read time: 0; Write time: 342304 05:23:55 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 81920; Write bytes: 291889152; Read time: 32; Write time: 233152 05:23:55 INFO - Running post-run listener: _upload_blobber_files 05:23:55 INFO - Blob upload gear active. 05:23:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:23:55 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:23:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:23:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:23:56 INFO - (blobuploader) - INFO - Open directory for files ... 05:23:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:23:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:23:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:23:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:23:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:23:56 INFO - (blobuploader) - INFO - Done attempting. 05:23:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:23:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:23:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:23:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:23:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:23:57 INFO - (blobuploader) - INFO - Done attempting. 05:23:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:23:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:23:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:24:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:24:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:24:01 INFO - (blobuploader) - INFO - Done attempting. 05:24:01 INFO - (blobuploader) - INFO - Iteration through files over. 05:24:01 INFO - Return code: 0 05:24:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:24:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:24:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5cd805844df7d2df6c4110429fdf869238f53831a62970e2e70db5e779a41c751cd6404bce12639135669b0b2ed0da867f7a6425de4291df349d655f9bb7fe72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cded7f25ef7788f113134405ff2580a360d9b89764ca0abc628238f6fd9814e682fc38314f22dd050c8615f91e22d77ae1982b11c19b636408a8f35f11e10b58", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5ab20da11ba79cd4e511a8a8cc6103564e8c079a4a41e7d4cb1d6855d63795d7be04b05ff458e28b736b970abb8f27b84ee0377dab8f76032fcdc1acbb91f33f"} 05:24:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:24:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:24:01 INFO - Contents: 05:24:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5cd805844df7d2df6c4110429fdf869238f53831a62970e2e70db5e779a41c751cd6404bce12639135669b0b2ed0da867f7a6425de4291df349d655f9bb7fe72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cded7f25ef7788f113134405ff2580a360d9b89764ca0abc628238f6fd9814e682fc38314f22dd050c8615f91e22d77ae1982b11c19b636408a8f35f11e10b58", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5ab20da11ba79cd4e511a8a8cc6103564e8c079a4a41e7d4cb1d6855d63795d7be04b05ff458e28b736b970abb8f27b84ee0377dab8f76032fcdc1acbb91f33f"} 05:24:01 INFO - Running post-run listener: copy_logs_to_upload_dir 05:24:01 INFO - Copying logs to upload dir... 05:24:01 INFO - mkdir: /builds/slave/test/build/upload/logs 05:24:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.503412 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-30 05:24:01.083542) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 05:24:01.086719) ========= 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=c6927cf182745ad25b1d38b9000001fe-1467288197.905028-419343367 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5cd805844df7d2df6c4110429fdf869238f53831a62970e2e70db5e779a41c751cd6404bce12639135669b0b2ed0da867f7a6425de4291df349d655f9bb7fe72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cded7f25ef7788f113134405ff2580a360d9b89764ca0abc628238f6fd9814e682fc38314f22dd050c8615f91e22d77ae1982b11c19b636408a8f35f11e10b58", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5ab20da11ba79cd4e511a8a8cc6103564e8c079a4a41e7d4cb1d6855d63795d7be04b05ff458e28b736b970abb8f27b84ee0377dab8f76032fcdc1acbb91f33f"} build_url:https://queue.taskcluster.net/v1/task/ElQf9aGWRkSR9qchoFWwNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011149 build_url: 'https://queue.taskcluster.net/v1/task/ElQf9aGWRkSR9qchoFWwNA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5cd805844df7d2df6c4110429fdf869238f53831a62970e2e70db5e779a41c751cd6404bce12639135669b0b2ed0da867f7a6425de4291df349d655f9bb7fe72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cded7f25ef7788f113134405ff2580a360d9b89764ca0abc628238f6fd9814e682fc38314f22dd050c8615f91e22d77ae1982b11c19b636408a8f35f11e10b58", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5ab20da11ba79cd4e511a8a8cc6103564e8c079a4a41e7d4cb1d6855d63795d7be04b05ff458e28b736b970abb8f27b84ee0377dab8f76032fcdc1acbb91f33f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 05:24:01.116877) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 05:24:01.120313) ========= 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=c6927cf182745ad25b1d38b9000001fe-1467288197.905028-419343367 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004439 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 05:24:01.170921) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 05:24:01.172340) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 05:24:01.172897) ========= ========= Total master_lag: 0.17 =========