builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-039 starttime: 1467768962.52 results: success (0) buildid: 20160705171423 builduid: a1cc2c7a45834e1db8084688e98aa01c revision: bfcca87598b2ca8e31094d587b7b5cd033ef9577 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 18:36:02.527017) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 18:36:02.527482) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 18:36:02.527785) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 18:36:02.566010) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 18:36:02.566284) ========= 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=5bd038846534b2fdfa68eeae000001e2-1467764471.942659-1642918687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-05 18:36:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-07-05 18:36:02 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.166075 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 18:36:02.750595) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 18:36:02.750918) ========= 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=5bd038846534b2fdfa68eeae000001e2-1467764471.942659-1642918687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.086378 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 18:36:02.853379) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 18:36:02.853772) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev bfcca87598b2ca8e31094d587b7b5cd033ef9577 --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 bfcca87598b2ca8e31094d587b7b5cd033ef9577 --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=5bd038846534b2fdfa68eeae000001e2-1467764471.942659-1642918687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-05 18:36:02,916 truncating revision to first 12 chars 2016-07-05 18:36:02,916 Setting DEBUG logging. 2016-07-05 18:36:02,916 attempt 1/10 2016-07-05 18:36:02,916 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/bfcca87598b2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 18:36:03,248 unpacking tar archive at: fx-team-bfcca87598b2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.680375 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 18:36:03.548333) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 18:36:03.548645) ========= script_repo_revision: bfcca87598b2ca8e31094d587b7b5cd033ef9577 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 18:36:03.549050) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 18:36:03.549324) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 18:36:03.561775) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-07-05 18:36:03.562077) ========= /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=5bd038846534b2fdfa68eeae000001e2-1467764471.942659-1642918687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:36:03 INFO - MultiFileLogger online at 20160705 18:36:03 in /builds/slave/test 18:36:03 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 18:36:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:36:03 INFO - {'append_to_log': False, 18:36:03 INFO - 'base_work_dir': '/builds/slave/test', 18:36:03 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 18:36:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:36:03 INFO - 'branch': 'Fx-Team-Non-PGO', 18:36:03 INFO - 'buildbot_json_path': 'buildprops.json', 18:36:03 INFO - 'config_files': ('talos/linux_config.py',), 18:36:03 INFO - 'default_actions': ('clobber', 18:36:03 INFO - 'read-buildbot-config', 18:36:03 INFO - 'download-and-extract', 18:36:03 INFO - 'populate-webroot', 18:36:03 INFO - 'create-virtualenv', 18:36:03 INFO - 'install', 18:36:03 INFO - 'run-tests'), 18:36:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:36:03 INFO - 'download_minidump_stackwalk': True, 18:36:03 INFO - 'download_symbols': 'ondemand', 18:36:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:36:03 INFO - 'tooltool.py': '/tools/tooltool.py', 18:36:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:36:03 INFO - '/tools/misc-python/virtualenv.py')}, 18:36:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:36:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:36:03 INFO - 'installer_path': 'installer.exe', 18:36:03 INFO - 'log_level': 'info', 18:36:03 INFO - 'log_name': 'talos', 18:36:03 INFO - 'log_to_console': True, 18:36:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:36:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:36:03 INFO - 'opt_config_files': (), 18:36:03 INFO - 'pip_index': False, 18:36:03 INFO - 'sps_profile': False, 18:36:03 INFO - 'sps_profile_interval': 0, 18:36:03 INFO - 'suite': 'dromaeojs-e10s', 18:36:03 INFO - 'system_bits': '32', 18:36:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:36:03 INFO - 'title': 'talos-linux64-ix-039', 18:36:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:36:03 INFO - 'use_talos_json': True, 18:36:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:36:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:36:03 INFO - 'work_dir': 'build'} 18:36:03 INFO - ##### 18:36:03 INFO - ##### Running clobber step. 18:36:03 INFO - ##### 18:36:03 INFO - Running pre-action listener: _resource_record_pre_action 18:36:03 INFO - Running main action method: clobber 18:36:03 INFO - rmtree: /builds/slave/test/build 18:36:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:36:05 INFO - Running post-action listener: _resource_record_post_action 18:36:05 INFO - ##### 18:36:05 INFO - ##### Finished clobber step (success) 18:36:05 INFO - ##### 18:36:05 INFO - ##### 18:36:05 INFO - ##### Running read-buildbot-config step. 18:36:05 INFO - ##### 18:36:05 INFO - Running pre-action listener: _resource_record_pre_action 18:36:05 INFO - Running main action method: read_buildbot_config 18:36:05 INFO - Using buildbot properties: 18:36:05 INFO - { 18:36:05 INFO - "project": "", 18:36:05 INFO - "product": "firefox", 18:36:05 INFO - "script_repo_revision": "production", 18:36:05 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 18:36:05 INFO - "repository": "", 18:36:05 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 18:36:05 INFO - "buildid": "20160705171423", 18:36:05 INFO - "pgo_build": "False", 18:36:05 INFO - "basedir": "/builds/slave/test", 18:36:05 INFO - "buildnumber": 1417, 18:36:05 INFO - "slavename": "talos-linux64-ix-039", 18:36:05 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:36:05 INFO - "platform": "ubuntu64_hw", 18:36:05 INFO - "scheduler": "tests-fx-team-linux64-talos", 18:36:05 INFO - "branch": "fx-team", 18:36:05 INFO - "repo_path": "integration/fx-team", 18:36:05 INFO - "revision": "bfcca87598b2ca8e31094d587b7b5cd033ef9577", 18:36:05 INFO - "stage_platform": "linux64", 18:36:05 INFO - "builduid": "a1cc2c7a45834e1db8084688e98aa01c", 18:36:05 INFO - "slavebuilddir": "test" 18:36:05 INFO - } 18:36:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/blVkHgK5T3u2Z1wnwUE_gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 18:36:05 INFO - Running post-action listener: _resource_record_post_action 18:36:05 INFO - ##### 18:36:05 INFO - ##### Finished read-buildbot-config step (success) 18:36:05 INFO - ##### 18:36:05 INFO - ##### 18:36:05 INFO - ##### Running download-and-extract step. 18:36:05 INFO - ##### 18:36:05 INFO - Running pre-action listener: _resource_record_pre_action 18:36:05 INFO - Running main action method: download_and_extract 18:36:05 INFO - mkdir: /builds/slave/test/build/tests 18:36:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:36:05 INFO - https://queue.taskcluster.net/v1/task/blVkHgK5T3u2Z1wnwUE_gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:36:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/blVkHgK5T3u2Z1wnwUE_gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:36:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/blVkHgK5T3u2Z1wnwUE_gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:36:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/blVkHgK5T3u2Z1wnwUE_gg/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 18:36:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/blVkHgK5T3u2Z1wnwUE_gg/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 18:36:10 INFO - Downloaded 1361 bytes. 18:36:10 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:36:10 INFO - Using the following test package requirements: 18:36:10 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 18:36:10 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:36:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:36:10 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:36:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:36:10 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:36:10 INFO - u'jsshell-linux-x86_64.zip'], 18:36:10 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:36:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:36:10 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 18:36:10 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:36:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:36:10 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:36:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:36:10 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:36:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:36:10 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:36:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:36:10 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:36:10 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')]} 18:36:10 INFO - https://queue.taskcluster.net/v1/task/blVkHgK5T3u2Z1wnwUE_gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:36:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/blVkHgK5T3u2Z1wnwUE_gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:36:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/blVkHgK5T3u2Z1wnwUE_gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:36:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/blVkHgK5T3u2Z1wnwUE_gg/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 18:36:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/blVkHgK5T3u2Z1wnwUE_gg/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 18:36:11 INFO - Downloaded 22730934 bytes. 18:36:11 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'] 18:36:11 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 18:36:12 INFO - Return code: 0 18:36:12 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 18:36:12 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')]} 18:36:12 INFO - https://queue.taskcluster.net/v1/task/blVkHgK5T3u2Z1wnwUE_gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:36:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/blVkHgK5T3u2Z1wnwUE_gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:36:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/blVkHgK5T3u2Z1wnwUE_gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:36:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/blVkHgK5T3u2Z1wnwUE_gg/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 18:36:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/blVkHgK5T3u2Z1wnwUE_gg/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 18:36:17 INFO - Downloaded 22730934 bytes. 18:36:17 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'] 18:36:17 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 18:36:19 INFO - Return code: 0 18:36:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 18:36:19 INFO - https://queue.taskcluster.net/v1/task/blVkHgK5T3u2Z1wnwUE_gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:36:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/blVkHgK5T3u2Z1wnwUE_gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:36:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/blVkHgK5T3u2Z1wnwUE_gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:36:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/blVkHgK5T3u2Z1wnwUE_gg/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 18:36:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/blVkHgK5T3u2Z1wnwUE_gg/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 18:36:20 INFO - Downloaded 14403333 bytes. 18:36:20 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'] 18:36:20 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 18:36:21 INFO - Return code: 0 18:36: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')]} 18:36:21 INFO - https://queue.taskcluster.net/v1/task/blVkHgK5T3u2Z1wnwUE_gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:36:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/blVkHgK5T3u2Z1wnwUE_gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:36:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/blVkHgK5T3u2Z1wnwUE_gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:36:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/blVkHgK5T3u2Z1wnwUE_gg/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 18:36:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/blVkHgK5T3u2Z1wnwUE_gg/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 18:36:22 INFO - Downloaded 56473763 bytes. 18:36:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/blVkHgK5T3u2Z1wnwUE_gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:36:22 INFO - mkdir: /builds/slave/test/properties 18:36:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:36:22 INFO - Writing to file /builds/slave/test/properties/build_url 18:36:22 INFO - Contents: 18:36:22 INFO - build_url:https://queue.taskcluster.net/v1/task/blVkHgK5T3u2Z1wnwUE_gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:36:23 INFO - Running post-action listener: _resource_record_post_action 18:36:23 INFO - Running post-action listener: set_extra_try_arguments 18:36:23 INFO - ##### 18:36:23 INFO - ##### Finished download-and-extract step (success) 18:36:23 INFO - ##### 18:36:23 INFO - ##### 18:36:23 INFO - ##### Running populate-webroot step. 18:36:23 INFO - ##### 18:36:23 INFO - Running pre-action listener: _resource_record_pre_action 18:36:23 INFO - Running main action method: populate_webroot 18:36:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:36:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:36:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:36:23 INFO - '--tppagecycles', 18:36:23 INFO - '7'], 18:36:23 INFO - 'tests': ['tsvgm']}}, 18:36:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:36:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:36:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:36:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:36:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:36:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:36:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:36:23 INFO - 'talos_options': ['--disable-e10s'], 18:36:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:36:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:36:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:36:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:36:23 INFO - 'talos_options': ['--disable-e10s'], 18:36:23 INFO - 'tests': ['damp', 'tps']}, 18:36:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:36:23 INFO - 'tests': ['damp', 'tps']}, 18:36:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:36:23 INFO - 'tests': ['dromaeo_dom']}, 18:36:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:36:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:36:23 INFO - 'tests': ['basic_compositor_video']}, 18:36:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:36:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:36:23 INFO - 'tests': ['a11yr', 18:36:23 INFO - 'ts_paint', 18:36:23 INFO - 'tpaint', 18:36:23 INFO - 'sessionrestore', 18:36:23 INFO - 'sessionrestore_no_auto_restore', 18:36:23 INFO - 'tabpaint']}, 18:36:23 INFO - 'other-e10s': {'tests': ['a11yr', 18:36:23 INFO - 'ts_paint', 18:36:23 INFO - 'tpaint', 18:36:23 INFO - 'sessionrestore', 18:36:23 INFO - 'sessionrestore_no_auto_restore', 18:36:23 INFO - 'tabpaint']}, 18:36:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:36:23 INFO - 'ts_paint', 18:36:23 INFO - 'tpaint', 18:36:23 INFO - 'sessionrestore', 18:36:23 INFO - 'sessionrestore_no_auto_restore', 18:36:23 INFO - 'tabpaint']}, 18:36:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:36:23 INFO - 'ts_paint', 18:36:23 INFO - 'tpaint', 18:36:23 INFO - 'sessionrestore', 18:36:23 INFO - 'sessionrestore_no_auto_restore', 18:36:23 INFO - 'tabpaint']}, 18:36:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:36:23 INFO - 'tests': ['a11yr', 18:36:23 INFO - 'ts_paint', 18:36:23 INFO - 'tpaint', 18:36:23 INFO - 'sessionrestore', 18:36:23 INFO - 'sessionrestore_no_auto_restore', 18:36:23 INFO - 'tabpaint']}, 18:36:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:36:23 INFO - 'tests': ['a11yr', 18:36:23 INFO - 'ts_paint', 18:36:23 INFO - 'tpaint', 18:36:23 INFO - 'sessionrestore', 18:36:23 INFO - 'sessionrestore_no_auto_restore', 18:36:23 INFO - 'tabpaint']}, 18:36:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:36:23 INFO - 'tests': ['tsvgx', 18:36:23 INFO - 'tsvgr_opacity', 18:36:23 INFO - 'tart', 18:36:23 INFO - 'tscrollx', 18:36:23 INFO - 'cart']}, 18:36:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:36:23 INFO - 'tsvgr_opacity', 18:36:23 INFO - 'tart', 18:36:23 INFO - 'tscrollx', 18:36:23 INFO - 'cart']}, 18:36:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:36:23 INFO - 'talos_options': ['--disable-e10s'], 18:36:23 INFO - 'tests': ['tp5o']}, 18:36:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:36:23 INFO - 'tests': ['tp5o']}, 18:36:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:36:23 INFO - 'talos_options': ['--disable-e10s', 18:36:23 INFO - '--xperf_path', 18:36:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:36:23 INFO - 'tests': ['tp5n']}, 18:36:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:36:23 INFO - 'talos_options': ['--xperf_path', 18:36:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:36:23 INFO - 'tests': ['tp5n']}}, 18:36:23 INFO - 'talos.zip': {'path': '', 18:36:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:36:23 INFO - Running post-action listener: _resource_record_post_action 18:36:23 INFO - ##### 18:36:23 INFO - ##### Finished populate-webroot step (success) 18:36:23 INFO - ##### 18:36:23 INFO - ##### 18:36:23 INFO - ##### Running create-virtualenv step. 18:36:23 INFO - ##### 18:36:23 INFO - Running pre-action listener: _resource_record_pre_action 18:36:23 INFO - Running main action method: create_virtualenv 18:36:23 INFO - Creating virtualenv /builds/slave/test/build/venv 18:36:23 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 18:36:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:36:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:36:23 INFO - Using real prefix '/usr' 18:36:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:36:24 INFO - Installing distribute.............................................................................................................................................................................................done. 18:36:26 INFO - Installing pip.................done. 18:36:26 INFO - Return code: 0 18:36:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:36:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 18:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:36:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:36:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 18:36:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:36:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:36:26 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 0xbce030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8c570>, '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 0xe8d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8d900>, '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': '5bd038846534b2fdfa68eeae000001e2-1467764471.942659-1642918687', '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 18:36:26 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 18:36:26 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 18:36:26 INFO - Using env: {'DISPLAY': ':0', 18:36:26 INFO - 'HOME': '/home/cltbld', 18:36:26 INFO - 'LANG': 'en_US.UTF-8', 18:36:26 INFO - 'LANGUAGE': 'en_US:en', 18:36:26 INFO - 'LOGNAME': 'cltbld', 18:36:26 INFO - 'MAIL': '/var/mail/cltbld', 18:36:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:36:26 INFO - 'MOZ_NO_REMOTE': '1', 18:36:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:36:26 INFO - 'NO_EM_RESTART': '1', 18:36:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:36:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:36:26 INFO - 'PWD': '/builds/slave/test', 18:36:26 INFO - 'SHELL': '/bin/bash', 18:36:26 INFO - 'SHLVL': '1', 18:36:26 INFO - 'TERM': 'linux', 18:36:26 INFO - 'TMOUT': '86400', 18:36:26 INFO - 'USER': 'cltbld', 18:36:26 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467764471.942659-1642918687', 18:36:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:36:26 INFO - '_': '/tools/buildbot/bin/python'} 18:36:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:36:27 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 18:36:27 INFO - Cleaning up... 18:36:27 INFO - Return code: 0 18:36:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:36:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 18:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:36:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:36:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 18:36:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:36:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:36:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xbce030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8c570>, '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 0xe8d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8d900>, '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': '5bd038846534b2fdfa68eeae000001e2-1467764471.942659-1642918687', '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 18:36:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:36:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:36:27 INFO - Using env: {'DISPLAY': ':0', 18:36:27 INFO - 'HOME': '/home/cltbld', 18:36:27 INFO - 'LANG': 'en_US.UTF-8', 18:36:27 INFO - 'LANGUAGE': 'en_US:en', 18:36:27 INFO - 'LOGNAME': 'cltbld', 18:36:27 INFO - 'MAIL': '/var/mail/cltbld', 18:36:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:36:27 INFO - 'MOZ_NO_REMOTE': '1', 18:36:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:36:27 INFO - 'NO_EM_RESTART': '1', 18:36:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:36:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:36:27 INFO - 'PWD': '/builds/slave/test', 18:36:27 INFO - 'SHELL': '/bin/bash', 18:36:27 INFO - 'SHLVL': '1', 18:36:27 INFO - 'TERM': 'linux', 18:36:27 INFO - 'TMOUT': '86400', 18:36:27 INFO - 'USER': 'cltbld', 18:36:27 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467764471.942659-1642918687', 18:36:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:36:27 INFO - '_': '/tools/buildbot/bin/python'} 18:36:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:36:27 INFO - Downloading/unpacking psutil>=3.1.1 18:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:36:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:36:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:36:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:36:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:36:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:36:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:36:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:36:29 INFO - Installing collected packages: psutil 18:36:29 INFO - Running setup.py install for psutil 18:36:29 INFO - building 'psutil._psutil_linux' extension 18:36:29 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 18:36:30 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 18:36:31 INFO - building 'psutil._psutil_posix' extension 18:36:31 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 18:36:31 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 18:36:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:36:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:36:31 INFO - Successfully installed psutil 18:36:31 INFO - Cleaning up... 18:36:31 INFO - Return code: 0 18:36:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:36:31 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')]} 18:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:36:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:36:31 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')]} 18:36:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:36:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:36:31 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 0xbce030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8c570>, '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 0xe8d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8d900>, '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': '5bd038846534b2fdfa68eeae000001e2-1467764471.942659-1642918687', '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 18:36:31 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 18:36:31 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 18:36:31 INFO - Using env: {'DISPLAY': ':0', 18:36:31 INFO - 'HOME': '/home/cltbld', 18:36:31 INFO - 'LANG': 'en_US.UTF-8', 18:36:31 INFO - 'LANGUAGE': 'en_US:en', 18:36:31 INFO - 'LOGNAME': 'cltbld', 18:36:31 INFO - 'MAIL': '/var/mail/cltbld', 18:36:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:36:31 INFO - 'MOZ_NO_REMOTE': '1', 18:36:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:36:31 INFO - 'NO_EM_RESTART': '1', 18:36:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:36:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:36:31 INFO - 'PWD': '/builds/slave/test', 18:36:31 INFO - 'SHELL': '/bin/bash', 18:36:31 INFO - 'SHLVL': '1', 18:36:31 INFO - 'TERM': 'linux', 18:36:31 INFO - 'TMOUT': '86400', 18:36:31 INFO - 'USER': 'cltbld', 18:36:31 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467764471.942659-1642918687', 18:36:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:36:31 INFO - '_': '/tools/buildbot/bin/python'} 18:36:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:36:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:36:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:36:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:36:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:36:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:36:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:36:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:36:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:36:33 INFO - Installing collected packages: mozsystemmonitor 18:36:33 INFO - Running setup.py install for mozsystemmonitor 18:36:33 INFO - Successfully installed mozsystemmonitor 18:36:33 INFO - Cleaning up... 18:36:33 INFO - Return code: 0 18:36:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:36:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 18:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:36:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:36:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 18:36:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:36:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:36:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xbce030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8c570>, '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 0xe8d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8d900>, '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': '5bd038846534b2fdfa68eeae000001e2-1467764471.942659-1642918687', '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 18:36:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:36:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:36:33 INFO - Using env: {'DISPLAY': ':0', 18:36:33 INFO - 'HOME': '/home/cltbld', 18:36:33 INFO - 'LANG': 'en_US.UTF-8', 18:36:33 INFO - 'LANGUAGE': 'en_US:en', 18:36:33 INFO - 'LOGNAME': 'cltbld', 18:36:33 INFO - 'MAIL': '/var/mail/cltbld', 18:36:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:36:33 INFO - 'MOZ_NO_REMOTE': '1', 18:36:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:36:33 INFO - 'NO_EM_RESTART': '1', 18:36:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:36:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:36:33 INFO - 'PWD': '/builds/slave/test', 18:36:33 INFO - 'SHELL': '/bin/bash', 18:36:33 INFO - 'SHLVL': '1', 18:36:33 INFO - 'TERM': 'linux', 18:36:33 INFO - 'TMOUT': '86400', 18:36:33 INFO - 'USER': 'cltbld', 18:36:33 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467764471.942659-1642918687', 18:36:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:36:33 INFO - '_': '/tools/buildbot/bin/python'} 18:36:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:36:33 INFO - Downloading/unpacking jsonschema==2.5.1 18:36:33 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 18:36:33 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 18:36:33 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 18:36:33 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 18:36:33 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 18:36:33 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 18:36:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:36:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:36:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:36:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:36:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:36:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:36:36 INFO - Downloading functools32-3.2.3-2.tar.gz 18:36:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:36:36 INFO - warning: no files found matching '*.txt' 18:36:36 INFO - no previously-included directories found matching 'build' 18:36:36 INFO - no previously-included directories found matching 'dist' 18:36:36 INFO - no previously-included directories found matching '.git*' 18:36:36 INFO - Installing collected packages: jsonschema, functools32 18:36:36 INFO - Running setup.py install for functools32 18:36:36 INFO - warning: no files found matching '*.txt' 18:36:36 INFO - no previously-included directories found matching 'build' 18:36:36 INFO - no previously-included directories found matching 'dist' 18:36:36 INFO - no previously-included directories found matching '.git*' 18:36:36 INFO - Successfully installed jsonschema functools32 18:36:36 INFO - Cleaning up... 18:36:36 INFO - Return code: 0 18:36:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:36:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:36:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:36:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:36:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:36:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:36:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:36:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xbce030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8c570>, '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 0xe8d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8d900>, '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': '5bd038846534b2fdfa68eeae000001e2-1467764471.942659-1642918687', '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 18:36:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:36:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:36:36 INFO - Using env: {'DISPLAY': ':0', 18:36:36 INFO - 'HOME': '/home/cltbld', 18:36:36 INFO - 'LANG': 'en_US.UTF-8', 18:36:36 INFO - 'LANGUAGE': 'en_US:en', 18:36:36 INFO - 'LOGNAME': 'cltbld', 18:36:36 INFO - 'MAIL': '/var/mail/cltbld', 18:36:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:36:36 INFO - 'MOZ_NO_REMOTE': '1', 18:36:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:36:36 INFO - 'NO_EM_RESTART': '1', 18:36:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:36:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:36:36 INFO - 'PWD': '/builds/slave/test', 18:36:36 INFO - 'SHELL': '/bin/bash', 18:36:36 INFO - 'SHLVL': '1', 18:36:36 INFO - 'TERM': 'linux', 18:36:36 INFO - 'TMOUT': '86400', 18:36:36 INFO - 'USER': 'cltbld', 18:36:36 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467764471.942659-1642918687', 18:36:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:36:36 INFO - '_': '/tools/buildbot/bin/python'} 18:36:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:36:36 INFO - Downloading/unpacking blobuploader==1.2.4 18:36:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:36:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:36:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:36:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:36:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:36:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:36:38 INFO - Downloading blobuploader-1.2.4.tar.gz 18:36:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:36:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:36: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 18:36: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 18:36: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 18:36: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 18:36: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 18:36: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 18:36:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:36:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:36: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 18:36: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 18:36: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 18:36: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 18:36: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 18:36: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 18:36:39 INFO - Downloading docopt-0.6.1.tar.gz 18:36:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:36:39 INFO - Installing collected packages: blobuploader, requests, docopt 18:36:39 INFO - Running setup.py install for blobuploader 18:36:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:36:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:36:39 INFO - Running setup.py install for requests 18:36:39 INFO - Running setup.py install for docopt 18:36:39 INFO - Successfully installed blobuploader requests docopt 18:36:39 INFO - Cleaning up... 18:36:39 INFO - Return code: 0 18:36:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:36:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 18:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:36:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:36:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 18:36:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:36:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:36:39 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 0xbce030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8c570>, '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 0xe8d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8d900>, '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': '5bd038846534b2fdfa68eeae000001e2-1467764471.942659-1642918687', '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 18:36:39 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 18:36:39 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 18:36:39 INFO - Using env: {'DISPLAY': ':0', 18:36:39 INFO - 'HOME': '/home/cltbld', 18:36:39 INFO - 'LANG': 'en_US.UTF-8', 18:36:39 INFO - 'LANGUAGE': 'en_US:en', 18:36:39 INFO - 'LOGNAME': 'cltbld', 18:36:39 INFO - 'MAIL': '/var/mail/cltbld', 18:36:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:36:39 INFO - 'MOZ_NO_REMOTE': '1', 18:36:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:36:39 INFO - 'NO_EM_RESTART': '1', 18:36:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:36:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:36:39 INFO - 'PWD': '/builds/slave/test', 18:36:39 INFO - 'SHELL': '/bin/bash', 18:36:39 INFO - 'SHLVL': '1', 18:36:39 INFO - 'TERM': 'linux', 18:36:39 INFO - 'TMOUT': '86400', 18:36:39 INFO - 'USER': 'cltbld', 18:36:39 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467764471.942659-1642918687', 18:36:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:36:39 INFO - '_': '/tools/buildbot/bin/python'} 18:36:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:36:40 INFO - Running setup.py (path:/tmp/pip-U1qCQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:36:40 INFO - Running setup.py (path:/tmp/pip-Cse39m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:36:40 INFO - Running setup.py (path:/tmp/pip-SaPPB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:36:40 INFO - Running setup.py (path:/tmp/pip-uLXtiQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:36:40 INFO - Running setup.py (path:/tmp/pip-i2jAdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:36:40 INFO - Running setup.py (path:/tmp/pip-h1DO2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:36:40 INFO - Running setup.py (path:/tmp/pip-qtm7wy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:36:40 INFO - Running setup.py (path:/tmp/pip-vC5KpX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:36:40 INFO - Running setup.py (path:/tmp/pip-_eye5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:36:40 INFO - Running setup.py (path:/tmp/pip-YHxV4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:36:40 INFO - Running setup.py (path:/tmp/pip-a0Xyw8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:36:40 INFO - Running setup.py (path:/tmp/pip-UdALUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:36:40 INFO - Running setup.py (path:/tmp/pip-TzLWlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:36:41 INFO - Running setup.py (path:/tmp/pip-dVLUVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:36:41 INFO - Running setup.py (path:/tmp/pip-RBR4Tb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:36:41 INFO - Running setup.py (path:/tmp/pip-zBTOdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:36:41 INFO - Running setup.py (path:/tmp/pip-LcQJcX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:36:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:36:41 INFO - Running setup.py install for manifestparser 18:36:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:36:41 INFO - Running setup.py install for mozcrash 18:36:41 INFO - Running setup.py install for mozdebug 18:36:41 INFO - Running setup.py install for mozdevice 18:36:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:36:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:36:41 INFO - Running setup.py install for mozfile 18:36:41 INFO - Running setup.py install for mozhttpd 18:36:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:36:41 INFO - Running setup.py install for mozinfo 18:36:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:36:42 INFO - Running setup.py install for mozInstall 18:36:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:36:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:36:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:36:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:36:42 INFO - Running setup.py install for mozleak 18:36:42 INFO - Running setup.py install for mozlog 18:36:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:36:42 INFO - Running setup.py install for moznetwork 18:36:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:36:42 INFO - Running setup.py install for mozprocess 18:36:42 INFO - Running setup.py install for mozprofile 18:36:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:36:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:36:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:36:42 INFO - Running setup.py install for mozrunner 18:36:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:36:42 INFO - Running setup.py install for mozscreenshot 18:36:42 INFO - Running setup.py install for moztest 18:36:42 INFO - Running setup.py install for mozversion 18:36:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:36:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:36:43 INFO - Cleaning up... 18:36:43 INFO - Return code: 0 18:36:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:36: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')]} 18:36:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:36:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:36: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')]} 18:36:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:36:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:36:43 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 0xbce030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8c570>, '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 0xe8d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8d900>, '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': '5bd038846534b2fdfa68eeae000001e2-1467764471.942659-1642918687', '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 18:36:43 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 18:36:43 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 18:36:43 INFO - Using env: {'DISPLAY': ':0', 18:36:43 INFO - 'HOME': '/home/cltbld', 18:36:43 INFO - 'LANG': 'en_US.UTF-8', 18:36:43 INFO - 'LANGUAGE': 'en_US:en', 18:36:43 INFO - 'LOGNAME': 'cltbld', 18:36:43 INFO - 'MAIL': '/var/mail/cltbld', 18:36:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:36:43 INFO - 'MOZ_NO_REMOTE': '1', 18:36:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:36:43 INFO - 'NO_EM_RESTART': '1', 18:36:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:36:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:36:43 INFO - 'PWD': '/builds/slave/test', 18:36:43 INFO - 'SHELL': '/bin/bash', 18:36:43 INFO - 'SHLVL': '1', 18:36:43 INFO - 'TERM': 'linux', 18:36:43 INFO - 'TMOUT': '86400', 18:36:43 INFO - 'USER': 'cltbld', 18:36:43 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467764471.942659-1642918687', 18:36:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:36:43 INFO - '_': '/tools/buildbot/bin/python'} 18:36:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:36:43 INFO - Running setup.py (path:/tmp/pip-3_RB2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:36:43 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)) 18:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:36:43 INFO - Running setup.py (path:/tmp/pip-DqBA6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:36:43 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)) 18:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:36:43 INFO - Running setup.py (path:/tmp/pip-QNNPoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:36:43 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)) 18:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:36:43 INFO - Running setup.py (path:/tmp/pip-anBhzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:36:43 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)) 18:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:36:43 INFO - Running setup.py (path:/tmp/pip-q83LkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:36:43 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)) 18:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:36:43 INFO - Running setup.py (path:/tmp/pip-xnxBWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:36:43 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)) 18:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:36:43 INFO - Running setup.py (path:/tmp/pip-e9Q2QL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:36:43 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)) 18:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:36:43 INFO - Running setup.py (path:/tmp/pip-GwQOxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:36:43 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)) 18:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:36:43 INFO - Running setup.py (path:/tmp/pip-r4lJe1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:36:43 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)) 18:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:36:43 INFO - Running setup.py (path:/tmp/pip-M_wVIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:36:44 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)) 18:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:36:44 INFO - Running setup.py (path:/tmp/pip-E9kpyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:36:44 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)) 18:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:36:44 INFO - Running setup.py (path:/tmp/pip-eG7TVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:36:44 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)) 18:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:36:44 INFO - Running setup.py (path:/tmp/pip-LFsVF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:36:44 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)) 18:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:36:44 INFO - Running setup.py (path:/tmp/pip-84j7fN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:36:44 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)) 18:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:36:44 INFO - Running setup.py (path:/tmp/pip-6sBNNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:36:44 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)) 18:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:36:44 INFO - Running setup.py (path:/tmp/pip-0e4eIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:36:44 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)) 18:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:36:44 INFO - Running setup.py (path:/tmp/pip-h3y81N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:36:44 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)) 18:36:44 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)) 18:36:44 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)) 18:36:44 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)) 18:36:44 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)) 18:36:44 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)) 18:36:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:36:44 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 18:36:44 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 18:36:44 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 18:36:44 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 18:36:44 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 18:36:44 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 18:36:46 INFO - Downloading blessings-1.6.tar.gz 18:36:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:36:46 INFO - Installing collected packages: blessings 18:36:46 INFO - Running setup.py install for blessings 18:36:46 INFO - Successfully installed blessings 18:36:46 INFO - Cleaning up... 18:36:46 INFO - Return code: 0 18:36:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:36:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:36:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:36:46 INFO - Reading from file tmpfile_stdout 18:36:46 INFO - Current package versions: 18:36:46 INFO - argparse == 1.2.1 18:36:46 INFO - blessings == 1.6 18:36:46 INFO - blobuploader == 1.2.4 18:36:46 INFO - docopt == 0.6.1 18:36:46 INFO - functools32 == 3.2.3-2 18:36:46 INFO - jsonschema == 2.5.1 18:36:46 INFO - manifestparser == 1.1 18:36:46 INFO - mozInstall == 1.12 18:36:46 INFO - mozcrash == 0.17 18:36:46 INFO - mozdebug == 0.1 18:36:46 INFO - mozdevice == 0.48 18:36:46 INFO - mozfile == 1.2 18:36:46 INFO - mozhttpd == 0.7 18:36:46 INFO - mozinfo == 0.9 18:36:46 INFO - mozleak == 0.1 18:36:46 INFO - mozlog == 3.2 18:36:46 INFO - moznetwork == 0.27 18:36:46 INFO - mozprocess == 0.22 18:36:46 INFO - mozprofile == 0.28 18:36:46 INFO - mozrunner == 6.11 18:36:46 INFO - mozscreenshot == 0.1 18:36:46 INFO - mozsystemmonitor == 0.3 18:36:46 INFO - moztest == 0.7 18:36:46 INFO - mozversion == 1.4 18:36:46 INFO - psutil == 3.1.1 18:36:46 INFO - requests == 1.2.3 18:36:46 INFO - wsgiref == 0.1.2 18:36:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:36: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')]} 18:36:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:36:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:36: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')]} 18:36:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:36:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:36:46 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 0xbce030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8c570>, '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 0xe8d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8d900>, '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': '5bd038846534b2fdfa68eeae000001e2-1467764471.942659-1642918687', '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 18:36:46 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 18:36:46 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 18:36:46 INFO - Using env: {'DISPLAY': ':0', 18:36:46 INFO - 'HOME': '/home/cltbld', 18:36:46 INFO - 'LANG': 'en_US.UTF-8', 18:36:46 INFO - 'LANGUAGE': 'en_US:en', 18:36:46 INFO - 'LOGNAME': 'cltbld', 18:36:46 INFO - 'MAIL': '/var/mail/cltbld', 18:36:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:36:46 INFO - 'MOZ_NO_REMOTE': '1', 18:36:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:36:46 INFO - 'NO_EM_RESTART': '1', 18:36:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:36:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:36:46 INFO - 'PWD': '/builds/slave/test', 18:36:46 INFO - 'SHELL': '/bin/bash', 18:36:46 INFO - 'SHLVL': '1', 18:36:46 INFO - 'TERM': 'linux', 18:36:46 INFO - 'TMOUT': '86400', 18:36:46 INFO - 'USER': 'cltbld', 18:36:46 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467764471.942659-1642918687', 18:36:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:36:46 INFO - '_': '/tools/buildbot/bin/python'} 18:36:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:36:47 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)) 18:36:47 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)) 18:36:47 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)) 18:36:47 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)) 18:36:47 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)) 18:36:47 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)) 18:36:47 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)) 18:36:47 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)) 18:36:47 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)) 18:36:47 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)) 18:36:47 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)) 18:36:47 INFO - Cleaning up... 18:36:47 INFO - Return code: 0 18:36:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:36:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:36:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:36:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:36:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:36:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:36:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:36:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xbce030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdfd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe8c570>, '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 0xe8d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8d900>, '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': '5bd038846534b2fdfa68eeae000001e2-1467764471.942659-1642918687', '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 18:36:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:36:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:36:47 INFO - Using env: {'DISPLAY': ':0', 18:36:47 INFO - 'HOME': '/home/cltbld', 18:36:47 INFO - 'LANG': 'en_US.UTF-8', 18:36:47 INFO - 'LANGUAGE': 'en_US:en', 18:36:47 INFO - 'LOGNAME': 'cltbld', 18:36:47 INFO - 'MAIL': '/var/mail/cltbld', 18:36:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:36:47 INFO - 'MOZ_NO_REMOTE': '1', 18:36:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:36:47 INFO - 'NO_EM_RESTART': '1', 18:36:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:36:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:36:47 INFO - 'PWD': '/builds/slave/test', 18:36:47 INFO - 'SHELL': '/bin/bash', 18:36:47 INFO - 'SHLVL': '1', 18:36:47 INFO - 'TERM': 'linux', 18:36:47 INFO - 'TMOUT': '86400', 18:36:47 INFO - 'USER': 'cltbld', 18:36:47 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467764471.942659-1642918687', 18:36:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:36:47 INFO - '_': '/tools/buildbot/bin/python'} 18:36:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:36:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:36:47 INFO - Cleaning up... 18:36:47 INFO - Return code: 0 18:36:47 INFO - Running post-action listener: _resource_record_post_action 18:36:47 INFO - Running post-action listener: _start_resource_monitoring 18:36:47 INFO - Starting resource monitoring. 18:36:47 INFO - ##### 18:36:47 INFO - ##### Finished create-virtualenv step (success) 18:36:47 INFO - ##### 18:36:47 INFO - ##### 18:36:47 INFO - ##### Running install step. 18:36:47 INFO - ##### 18:36:47 INFO - Running pre-action listener: _resource_record_pre_action 18:36:47 INFO - Running main action method: install 18:36:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:36:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:36:47 INFO - Reading from file tmpfile_stdout 18:36:47 INFO - Detecting whether we're running mozinstall >=1.0... 18:36:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:36:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:36:47 INFO - Reading from file tmpfile_stdout 18:36:47 INFO - Output received: 18:36:47 INFO - Usage: mozinstall [options] installer 18:36:47 INFO - Options: 18:36:47 INFO - -h, --help show this help message and exit 18:36:47 INFO - -d DEST, --destination=DEST 18:36:47 INFO - Directory to install application into. [default: 18:36:47 INFO - "/builds/slave/test"] 18:36:47 INFO - --app=APP Application being installed. [default: firefox] 18:36:47 INFO - mkdir: /builds/slave/test/build/application 18:36:47 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'] 18:36:47 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 18:37:03 INFO - Reading from file tmpfile_stdout 18:37:03 INFO - Output received: 18:37:03 INFO - /builds/slave/test/build/application/firefox/firefox 18:37:03 INFO - Running post-action listener: _resource_record_post_action 18:37:03 INFO - ##### 18:37:03 INFO - ##### Finished install step (success) 18:37:03 INFO - ##### 18:37:03 INFO - ##### 18:37:03 INFO - ##### Running run-tests step. 18:37:03 INFO - ##### 18:37:03 INFO - Running pre-action listener: _resource_record_pre_action 18:37:03 INFO - Running main action method: run_tests 18:37:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:37:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:37:03 INFO - Python 2.7.3 18:37:03 INFO - Return code: 0 18:37:03 INFO - grabbing minidump binary from tooltool 18:37:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 18:37:03 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 0xe8c570>, '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 0xe8d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe8d900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:37:03 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 18:37:03 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 18:37:03 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 18:37:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:37:04 INFO - Return code: 0 18:37:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:37:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:37:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:37:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:37:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:37:04 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/blVkHgK5T3u2Z1wnwUE_gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 18:37:04 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/blVkHgK5T3u2Z1wnwUE_gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --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 18:37:04 INFO - Using env: {'DISPLAY': ':0', 18:37:04 INFO - 'HOME': '/home/cltbld', 18:37:04 INFO - 'LANG': 'en_US.UTF-8', 18:37:04 INFO - 'LANGUAGE': 'en_US:en', 18:37:04 INFO - 'LOGNAME': 'cltbld', 18:37:04 INFO - 'MAIL': '/var/mail/cltbld', 18:37:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:37:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:37:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:37:04 INFO - 'MOZ_NO_REMOTE': '1', 18:37:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:37:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:37:04 INFO - 'NO_EM_RESTART': '1', 18:37:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:37:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:37:04 INFO - 'PWD': '/builds/slave/test', 18:37:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:37:04 INFO - 'SHELL': '/bin/bash', 18:37:04 INFO - 'SHLVL': '1', 18:37:04 INFO - 'TERM': 'linux', 18:37:04 INFO - 'TMOUT': '86400', 18:37:04 INFO - 'USER': 'cltbld', 18:37:04 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467764471.942659-1642918687', 18:37:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:37:04 INFO - '_': '/tools/buildbot/bin/python'} 18:37:04 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/blVkHgK5T3u2Z1wnwUE_gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 18:37:04 INFO - mozversion application_buildid: 20160705171423 18:37:04 INFO - mozversion application_changeset: bfcca87598b2ca8e31094d587b7b5cd033ef9577 18:37:04 INFO - mozversion application_display_name: Nightly 18:37:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:37:04 INFO - mozversion application_name: Firefox 18:37:04 INFO - mozversion application_remotingname: firefox 18:37:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:37:04 INFO - mozversion application_vendor: Mozilla 18:37:04 INFO - mozversion application_version: 50.0a1 18:37:04 INFO - mozversion platform_buildid: 20160705171423 18:37:04 INFO - mozversion platform_changeset: bfcca87598b2ca8e31094d587b7b5cd033ef9577 18:37:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:37:04 INFO - mozversion platform_version: 50.0a1 18:37:04 INFO - using testdate: 1467769024 18:37:04 INFO - actual date: 1467769024 18:37:04 INFO - starting webserver on 'localhost:46355' 18:37:04 INFO - SUITE-START | Running 2 tests 18:37:04 INFO - TEST-START | dromaeo_css 18:37:04 INFO - operating with platform_type : linux_ 18:37:04 INFO - Initialising browser for dromaeo_css test... 18:37:04 INFO - TEST-INFO | started process 3307 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppnpfOL/profile http://localhost:46355/getInfo.html) 18:37:14 INFO - PROCESS | 3307 | __metrics Screen width/height:1600/1200 18:37:14 INFO - PROCESS | 3307 | colorDepth:24 18:37:14 INFO - PROCESS | 3307 | Browser inner width/height: 1024/697 18:37:14 INFO - PROCESS | 3307 | __metrics 18:37:15 ERROR - PROCESS | 3307 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2952: TypeError: this.tabs is undefined 18:37:16 INFO - TEST-INFO | 3307: exit 0 18:37:16 INFO - Browser initialized. 18:37:16 INFO - Running cycle 1/1 for dromaeo_css test... 18:37:16 INFO - TEST-INFO | started process 3430 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppnpfOL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:37:28 INFO - PROCESS | 3430 | RSS: Main: 170024960 18:37:28 INFO - PROCESS | 3430 | 18:38:18 INFO - PROCESS | 3430 | 1467769098025 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] 18:40:30 INFO - PROCESS | 3430 | Cycle 1(1): loaded http://localhost:46355/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46355/tests/dromaeo/cssquery-ext.html) 18:40:31 INFO - PROCESS | 3430 | RSS: Main: 170127360 18:40:31 INFO - PROCESS | 3430 | 18:43:33 INFO - PROCESS | 3430 | Cycle 1(1): loaded http://localhost:46355/tests/dromaeo/cssquery-ext.html (next: http://localhost:46355/tests/dromaeo/cssquery-jquery.html) 18:43:34 INFO - PROCESS | 3430 | RSS: Main: 169189376 18:43:34 INFO - PROCESS | 3430 | 18:46:36 INFO - PROCESS | 3430 | Cycle 1(1): loaded http://localhost:46355/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46355/tests/dromaeo/cssquery-mootools.html) 18:46:36 INFO - PROCESS | 3430 | RSS: Main: 172630016 18:46:36 INFO - PROCESS | 3430 | 18:49:38 INFO - PROCESS | 3430 | Cycle 1(1): loaded http://localhost:46355/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46355/tests/dromaeo/cssquery-prototype.html) 18:49:39 INFO - PROCESS | 3430 | RSS: Main: 168255488 18:49:39 INFO - PROCESS | 3430 | 18:52:42 INFO - PROCESS | 3430 | Cycle 1(1): loaded http://localhost:46355/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46355/tests/dromaeo/cssquery-yui.html) 18:52:42 INFO - PROCESS | 3430 | RSS: Main: 169717760 18:52:42 INFO - PROCESS | 3430 | 18:55:45 INFO - PROCESS | 3430 | Cycle 1(1): loaded http://localhost:46355/tests/dromaeo/cssquery-yui.html (next: http://localhost:46355/tests/dromaeo/cssquery-dojo.html) 18:55:45 INFO - PROCESS | 3430 | RSS: Main: 170897408 18:55:45 INFO - PROCESS | 3430 | 18:55:45 INFO - PROCESS | 3430 | __start_tp_report 18:55:45 INFO - PROCESS | 3430 | _x_x_mozilla_page_load 18:55:45 INFO - PROCESS | 3430 | _x_x_mozilla_page_load_details 18:55:45 INFO - PROCESS | 3430 | |i|pagename|runs| 18:55:45 INFO - PROCESS | 3430 | |0;dojo.html;2627.8817453214606;2647.1529110684583;2676.5583678693015;2677.812553121281;2682.7183145769695;4752.477227504976;4755.857324280277;4762.047590481904;4825.662203645747;4886.1204983103025;4756.310335001423;4817.566419022287;4818.229083346665;4838.104950584136;4844.442889067758;4392.363107349441;4413.3821265022925;4519.52544982777;4532.932006019896;4549.954500455003;576.5759319795426;4144.937825932613;4395.208862404766;4443.15580039793;4447.510773814878;4454.175977444183;4457.6433885289425;4469.508354081048;4477.529859364752;4500.234960056766;4488.304312831517;4491;4501.572350626685;4504.301833215824;4521.253993091136;4362.890927726832;4417.293233082692;4433.113377324548;4440.023194897118;4444.577765112309;4811.182099043171;4815.253635686439;4842.5157484251295;4848.903021939542;4851.854444366674;5057.848264552033;5145.536901678867;5202.869928251786;5206.24509446132;5232.6860388376435;5194.6104042196985;5227.503387178212;5234.16253399458;5238.973805130988;5241.764120614544;4845.030993801254;4848.321235027099;4868.294097355899;4878.02455401485;4932.136876046749;5203.687778733288;5225.085610018232;5227.163653815372;5352.732363381893;5362.51737343641;4998.400191976986;5009.44896061433;5020.623453241022;5035.496450355008;5071.594272458195;5106.259592359087;5108.7190204538365;5112.693238405707;5133.845984620468;5155.561777248976;4973.303737476756;5064.215046667772;5074.797008119708;5121.974390128025;5144.151215049475;5098.668586541937;5103.489651034867;5114.258432527263;5121.667091639031;5141.25451809493;4253.744775313429;4284.700070995063;4303;4316.525182229952;4349.391085248068;3678.981605092011;3685.0787303174206;3740.401535754266;3761.4733937248807;3814.256220037066;4430.4683437987005;4449.644028477714;4464.263396539534;4488.887777805516;4491.079328737601;5191.169412893994;5211.609129315317;5225.869353266199;5239.711815850089;5270.183121616155;4498.482674492409;4524.16302983949;4526.4115664964;4549.636029117729;4574.839880604163;4475.507694153641;4589.954100458953;4625.5836974671765;4628.930566041512;4641.234196357564;4934.654574179773;4940.629452790983;4951.653384263211;4951.702897826142;4977.726225057584;5188.766505507186;5219.973900130475;5230.293910322058;5242.895142097213;5260.868478288074;4764.190087685171;4856.611471082376;4915.066137433876;4944.703317800943;4977.527134922177;5178.404483484447;5179.326687530597;5190.8961820764125;5192.922106168335;5194.35070616173;5196.870078248074;5198.0643484173215;5205.58355331565;5213.60897932649;5255.868603284948;4835.879103022453;4932.186189278729;4965.354503914468;5012.273220383097;5019.422766381913;4960.603151747924;4970.279309500174;4979.551840334388;4992.600591952708;5014.598832093497;4821.349117869043;4918.163912135017;4922.901541969212;4935;4957.702537847741;4956.925646115384;4959.404871415453;4967.925481117713;4977.651564390458;5008.148614735576;4922.163232250455;4930.778114984762;4942.28336891156;4943.406791185081;4970.005998800327 18:55:45 INFO - PROCESS | 3430 | |1;ext.html;585.508173134567;587.9265091863518;606.6087373644;650.9804705858826;657.355791324502;32429.83785081074;33189.17027074324;36164.819175904086;36229.63770362295;36241.09397265063;37185.44221836675;37887.24225515488;37999.05002374942;38040.619593804055;38145;7511.812204694886;7682.846343073135;7684.38524918008;7696.961515192416;7700.383969282444;7595.088589369256;7606.695732170707;7652.349550288232;7685.730999415022;7736.419768517356;7703.4222433317445;7727.845443091135;7750.2637249461495;7766.262205090507;7775.6500957456765;7680.308772210527;7700.345470634975;7717.344025757818;7729.768106956801;7753.767386978371;7613.885791713129;7735.265149810759;7758.418118641124;7784.922150778533;7799.8440031199625;34939;35077.824610876785;35114.122146946276;35126.64873351285;35279.4708079379;2045.110376986001;2655.150351887397;2893.4647090288363;2950.336174360773;3014.788964772467;27474.313142171606;27657.170284891487;27967.440651186862;28036.299092522648;28840.278993025342;3347.2468694543777;3354.060862958351;3384.5769278840144;3439.8796042138656;3496.0385893879134;221998;222296;223031;223042;223314;31741.20646983844;31805.52291715626;31884.681153188172;32640.836795816344;32901.83549082239;33379.83310083434;33594.664053359644;33773.66226337705;33791.15522111967;33872;13395.330233488286;13576.456941722417;13580.320983950764;13597.728045439037;13631;11103.777924441465;11209.551617935354;11269;11276.774464510663;11290.887091129149;7698.884516732253;7742.8838567421535;7744.845103097907;7775.650095745705;7796.649150788228;3088.2896933705374;3157.0371036833526;3166.746660267173;3183.1564635371647;3225.580674512298;868.2142660891903;889.0886840988039;893.5442924108621;960.6013504395597;990.1336330710628;28236.15291541257;28609;28825.27936801555;29125.56311655327;29284.707152928626;908.2869947091501;951.9381240219363;956.5695437053215;958.2717134977468;998.1964518562627;15349.386024559117;15384.846151538566;15408.845911540966;15596.376144954302;15664.765028524582;453972;463609;463905;692419;702712;49672.751636241584;50703.239451408255;50722.492775071776;50739.68712659391;50920.23619645708;1179.8584169899666;1224.8530176378893;1236.4992178167856;1241.85097788266;1249.731307768834;27698.86150569315;28227.294317642223;29162;29252.414951701274;29584.55623165611;42467.3629895558;42564.1487170261;42936.35595466133;43038;43052.56947430611;335723;338349;340318;341761;343128;25411.36471588225;25578.488430231664;25709.871450642626;25815.870920645277;25930.61104083478;41450.170996580506;41824.163516728884;41859.7907010463;42110.157796844505;42471.78764106159;36353.63646363608;36656.633433666386;36806;37128.443073354465;37722.81138594289;35991.46012809758;36022.4596631056;36108.63891361053;36188.27623447464;36283.27433451264;32003.199920001254;34967;35455.29089418145;35636;37964;31339.216519587193;32670.83664581662;32967.83516082404;33028.83485582557;33134.183594394744;24866.627000595367;25394;25550.744492554837;25733.871330643226;25824.22527324183 18:55:45 INFO - PROCESS | 3430 | |2;jquery.html;367.83631284078564;372.9123655940853;375.29819238024896;383.0423940149626;383.7160501229091;16479.75280370794;17713.83803150748;17788.377406790765;18545.07274636266;18586.256549738013;17112.14439278034;17499.562510937234;17702.557436064104;17869.82130178698;17900.28398864044;5081.288619593269;5255.500727430907;5262.552683021948;5281.075811732951;5287.814926477574;3664.0050348110044;4106.650934670542;5201.817936372227;6310.716017779211;6328.08242804793;6177.722002509875;6212.1303017577575;6213.658248796337;6232.283287421937;6265.686715664221;6098.115773212904;6107.4808641265545;6241.407066328691;6241.687915604201;6271.937280627204;5407.648502847303;5408.513233808976;5441;5445.673259604437;5451.836444906619;20930.895345523328;21319.68020479694;21467.141314347406;21467.355979320644;21615.567688646297;1739.9130043497773;1995.5909038647042;2018.7880272571463;2109.69409435631;2421.1889017179265;9383.671571495033;9524.90475095254;9641.180499657537;9687.450007998757;9753.756156096084;1696.2706036404466;1705.7185564381862;1724.6378260565295;1776.3516316544496;1874.6813041782793;72994;74995;75047.62476187639;75139.24860751377;75181.24818751797;10180.389176649425;10245.334053286513;10268.589256429808;10348.068673819242;10538.63114790994;13954;13996.090254133449;14035.649108772363;14036.929815350857;14062.648433789238;6933.930660693329;7084.716611335592;7234.204237533867;7354.485186036926;7361.190269070398;6836.487263455261;6855.725770969106;6895.862082758316;7049.753258636026;7106.644667766591;4321.416608757841;4386.363977223285;4392.231359512072;4456.264716321771;4478.910421791546;1841.0242571437159;1862.9347972820885;1878.7557617509635;1883.5950270691867;1910.5032691500032;382.2698645586971;814.6619153051417;848.4866655673352;879.8284334554828;910.7677542226822;10241.94879025615;16779.244933978;16815;18170.364037258896;19625.626206165718;861.3539845116163;901.3330135699666;922.7785331520387;932.021377553566;948.6395169835419;9761.36551124189;10115.443650599287;10122.240831937634;10149.137323327599;10324.948375258076;387316;394603;395650;401731;404168;62085.68957155276;80613;84102;85135.99999999876;86250.56874715711;932.6222879733718;937.3906960475609;947.1475671895349;963.349738926222;967.709687093869;14658.780118298448;16584;16617.41839035628;16828.15859207059;16980.235889385254;26881.462370752866;29805.254868628457;31389.90135345343;33139.50290745689;38387.6161238384;51474.48525514697;52500.47499525108;53253.4674653264;54074.72962635162;55274.170887437525;7790.766277011472;7940.245676660708;7980.720674776355;7982.920170798217;8049.436539442183;8904.19862212404;11818.586349477728;12224.572139975058;12285.447154877873;12495.062870284582;9674.613015479303;9868.703938881845;9922.702318930444;10837.620683276047;11068.501917413574;9835.409875407498;10358.741031473972;10380.532876020749;10523.158147348347;10766.300190487593;9768.80462390734;10931.4888273168;10958.780824383628;11048.889511104786;11294;7429.8142546436775;7508;7577.772666820004;7640.465167438226;7645.541267523967;9781;9965.701028969142;10322.225833062701;10344.896551034695;10792.460376981277 18:55:45 INFO - PROCESS | 3430 | |3;mootools.html;1369.1511263016928;1425.750493663609;1500.9924950375246;1720.7849018872641;1744.4940967119535;7051.682674279657;7687.154413014564;7772.650230739616;8195.426320157583;8235.752927412172;7824;8006.0793008804;8026.598670066503;8032.156623554531;8113.675452981888;2199.186301068603;2243.719535058118;2246.1240116354634;2259.9661005084936;2263.8302127340517;2184.628613135763;2191.1125993972387;2233.7207849018873;2234.0505285253785;2250.549890021994;2226.4100013496354;2229.230915334207;2239.6304609739373;2241.204372447774;2263.0608297556496;2142.4001279641725;2143.228437762404;2163.772803855596;2164.8701077935298;2171.8489200723643;2176.8258539316816;2183.1376606240606;2199.1533259694975;2213.2143089203423;2222.733272007353;8143.307818835406;8248.340132789423;8274.503529788231;8275.462094963808;8286.917130828675;4648.976755116237;4774.331593576902;4790.8323208687525;4791.161546729309;4812.181929072066;2796.286946828566;2982.0606508949827;2989.5216765317446;2995.715407036328;2997.970020299813;875.6165258890937;899.6131663384742;921.8617207418873;925.7086364521522;925.8611208318739;10884.020438160524;10919.12646988239;10943;10966.232363734542;10988.285761425483;4013.57857424972;4130.690198235145;4215.78921053946;4235.25882970479;4241.766702831374;9265.44407335562;9357.344985851061;9393.624255029723;9426.670066547775;9473.66842160521;4732.881677958009;4753.714777113384;4758.643101767381;4776.546228108394;4777.546133117417;3717.368047431943;4209.705320627527;4304.225239456865;4317.0934103838545;4327.545607711145;3722.2927643748144;3767.3030489359007;3881.437191607258;3890.7665540067687;3982.203559288154;1158.8841115888345;1213.2780995307953;1219.3171823778712;1232.4761976160096;1234.388977456147;734.4418242136015;785.344237561631;809.5709274084744;823.5264722784423;825.8141918068386;5025.39695236574;5111.182210846247;5153.3558305211845;5202.713850738246;5287.101192797234;859.6546404876349;887.9556022198864;898.1377877237794;907.3739120007306;912.3932584831146;3320.369129865318;3323.7174840138377;3361.4453615153716;3387.7459190560808;3445.7423040590006;9772.462514561625;9960.501974901226;10050.497475126214;10099.848502272473;10115.241356898263;9945.353552019096;10004.19966402686;10005.899941000642;10009.499525023719;10021.29850910444;7471.589062601501;7524.510906791041;7593;7653.770386888402;7663.157052724196;5019.673721208256;5086.465921078381;5122.641415101056;5136.5377116059735;5203.453637368022;9209.355345125778;9216.723498295061;9226.677066302647;9228.123328283802;9474.52627368615;9182.127697868691;9489.810203795747;9501.857472138061;9529.952350238205;9582.185514231369;5732.799352022659;6341.587796793194;6493.22081350241;6499.285078641251;6623;7713;7762.961185194038;7792.6103694816165;7794.142644309008;7850.568218748023;6582.440492558187;6738.292479289604;6872.037914691847;6932.7226910923;6960.199577048705;6757.729690812313;6802.557833740791;6872.656367181721;6957.756478523227;7073.610951397723;5846.386129456346;5875.471207591338;5919.408059194218;5971.58198926071;5983.252093488314;4337.501187363494;4347.891302717458;4406.942333839919;4416.470023597189;4427.247367947392;4534.501204867528;4548.613367863769;4643.071385722937;4671.813127474863;4673.135469938073 18:55:45 INFO - PROCESS | 3430 | |4;prototype.html;302.86825231024505;303.20106519321587;303.8966751304556;303.96200474940633;305.57982773686194;5080.949190508099;5096.210087436449;5097.5157360050825;5109.208072748721;5131.743412829353;4982.302477653131;5029.421616514102;5039.949600503994;5050.873728156798;5070.569001634856;3805.885823425295;3935.48838650975;4001.899952501182;4003.879883603482;4013.157236980223;3990.7206495545324;3992.7005474589378;3999.520057593093;4014.116894283253;4026.255142798592;3979.5224573051128;3995.900102497432;4001.4598029266112;4022.557518672944;4037.454943582623;3679.9264014719824;3924.646781789653;3970.7816070116132;4007.839686412555;4016.3975403689387;3421.5723034620673;3449.6550344965303;3452.9309413811584;3458.792472451661;3466.254755227613;4965.925511117336;4980.2778597103215;4994.55049045584;5008.574271186953;5036.320096786923;4364.912701745948;4525.2533332000185;4525.660575456821;4528.682992190548;4560.521145279731;5250.5274525292525;5312.814051508179;5350.759215835258;5363.195520671891;5379.569634429236;3869.4776205212497;3869.961300386988;3878.3794592865006;3885.922281554353;3891.4746509221177;5313.352860613222;5518.19986102013;5603.775848966036;5616.550675945915;5643.6049476536655;3825.139343647713;3841.2317536492815;3859.7684138951754;3868.0909986153233;3870.59358767331;3881.378979363288;3884.1454879926373;3906.882793516199;3909.2181563687377;3916.099297161669;4465.352523884084;4470.798814053375;4472.955270447319;4477.462704475483;4479.216137175981;5154.433012368637;5321.175217841241;5327.387350454747;5391.81128660495;5406.324209473816;1369.2674419185687;1371.7448534590937;1388.7916812478209;1391.5060153645513;1392.1090502078678;896.7714231502882;908.2824568590739;924.255973940984;924.3344791749929;940.6002448959165;4536.77316134192;4597.885052873638;4617.953820461819;4663.160631086437;4677.859664210079;5368.758405871745;5417.702026388508;5462.699551524624;5467.20725494801;5471.151971444432;4553.4991150973365;4599.6090332321455;4616.407339467878;4617.561331673485;4650.674452788272;2866.656001279818;2869.6556413230546;2888.1913064342016;2892.248015515981;2899.782516311243;5103.362079740033;5119.846404607868;5125.231215317732;5131.692098474104;5131.820386286462;5301.6818990860675;5495.587830912697;5502.9174562380795;5525.972370138124;5539.695316757537;5057.620678449058;5098.311727916758;5112.156494178419;5142.023015627019;5144.408393034774;5319.973400132974;5354;5358.732063396893;5412.594055445778;5443.210734443563;5171.7934880374405;5311.362636483646;5480.479354461319;5482.80810171642;5500;5245.501677340647;5259.47405259471;5266.447023062523;5267.13092339775;5286.497782710637;3875.689944804465;3885.9417108743955;3899.2006638638445;3901.219756048745;3905.00844569266;5414.566834653139;5466.480684334982;5530.004599172187;5530.308711411074;5540.390557038803;5259.500347466985;5304.177852432879;5311.256424100707;5356.705381204071;5373.247745315737;5086.745662716923;5283.339582552181;5297.549708274686;5298.364196296469;5315.760790764348;5174.379074511083;5182.870428239325;5192.480751924777;5225.1378522543355;5226.503482169188;5125.128728116304;5208.244804503402;5400.324959380077;5413.9729301353245;5431.37539182999;5253.23828044939;5284.26020357158;5307.9734601326745;5309.920351194813;5320.255164277081 18:55:45 INFO - PROCESS | 3430 | |5;yui.html;572.9398413166617;581.7934633205209;599.4515018757837;612.2713970375253;618.15313021161;11100.55597776089;11650.941745291282;11717.882821171796;11735.11986601005;11737.06103511719;9724.465154416504;11683.766324673501;11701.531938722463;11745.47145378458;11751.823722644145;623.2334228898458;758.1395116542709;762.4662736084736;789.0846617923211;798.6805277888833;787.0122995640463;789.4394979564516;790.0322105420871;790.0795573157264;794.6860989908982;825.3974598543067;833.4166083741375;833.8790875323105;833.9666413343489;835.1940377535677;818.7666515043214;824.3858325547445;824.6371596497522;825.0965193113531;827.1191181391798;599.5802937943413;600.6006006006;604.0425924909024;606.1302031584646;606.1786279591134;11771.882281177164;11784.116191285688;11793.646190614296;11817.586384476503;11884.821727674092;12536.310502922335;12954.157979731288;12972.351382430936;13019.153755005895;13149.737005259842;9889.159421449185;9930.602775889029;9931.106200441922;10044.045815647502;10178.083972442442;3185.108169712461;3222.1783445221554;3256.1045712429036;3266.657001014883;3294.802311861296;61388;61652.383476165116;61713.691431543004;62446.0633090504;62776;9198.678046268482;9499.373530542358;9505.334626576074;9544.665936692183;9633.855492167622;16882.831171688125;17078.48764537066;17137.400190993256;17161.828381716274;17194.1402929853;6448.903266451007;6488.448481878999;6554.737810487527;6656.2345330287635;6707.262201157869;3625.2930678517437;3629.8185090745355;3692.2246328270826;3693.759905606127;3704.833282502294;2733.685626152978;2805.9158225253277;2818.760405365526;2819.957700634492;2871.5261981772774;485.1921550618252;486.72013592184635;491.46921324968946;499.5928318420548;504.208392823264;497.14242930944556;544.3957207499673;567.7842419880419;578.1328007988018;589.9262592175978;7556.962215188889;7845.5684937329;8084.878726819103;8252.298554622805;8694.435281534541;521.5983692556711;629.5813284165978;640.4620119099885;645.2321737132797;645.6900687669945;3836.6558460956526;3981.163955569305;4004.2592120457807;4015.1367455996515;4019.2765302245875;89752.5512372434;94281;95567;95571;95738.98029253527;81261.59369203117;83541.58229208815;87201.40784513699;88096.559517202;88120.55939720261;75149;75594.24405755982;77021;77066.61466692743;77500.61249693828;7377.631118444164;7397.482176247611;7442.806808595193;7563.886541701989;7565.659545320584;45315.32027019531;45699;45823.541764581925;46742.76628616835;47247.76376118098;56695.14957275562;57590.42409576018;62732.37267627265;64960;66548.33451665421;9356.812863742824;9847.950760246153;11293.522641518692;11550.133739969368;11684.357360345262;13349.599512014654;13376.398062087035;13423.865761342653;14231.715365692835;14331.06848054873;11932.28406295625;12049.33728644933;12348.938255308665;12352.320622365856;12449.688757780765;12031.518739250681;12096.153269271066;12181;12632.43154058088;12876;11154.888451115385;11260.09919206478;11514.251573647685;11942.940285298519;12219.633410997685;10298.433586152834;10697.090747286567;10898.455077246264;10933.890661093605;10990.615328463466;10099.141572966086;10322.432266225429;10392.116670083127;10447.791044179226;10455.11131553796 18:55:45 INFO - PROCESS | 3430 | __end_tp_report 18:55:45 INFO - PROCESS | 3430 | __start_cc_report 18:55:45 INFO - PROCESS | 3430 | _x_x_mozilla_cycle_collect,397 18:55:45 INFO - PROCESS | 3430 | __end_cc_report 18:55:45 INFO - PROCESS | 3430 | __startTimestamp1467770145780__endTimestamp 18:55:45 INFO - PROCESS | 3430 | 18:55:45 INFO - PROCESS | 3430 | ------- Summary: start ------- 18:55:45 INFO - PROCESS | 3430 | Number of tests: 6 18:55:45 INFO - PROCESS | 3430 | 18:55:45 INFO - PROCESS | 3430 | [#0] dojo.html Cycles:165 Average:4744.35 Median:4932.14 stddev:605.43 (12.3%) stddev-sans-first:584.08 18:55:45 INFO - PROCESS | 3430 | Values: 2627.9 2647.2 2676.6 2677.8 2682.7 4752.5 4755.9 4762.0 4825.7 4886.1 4756.3 4817.6 4818.2 4838.1 4844.4 4392.4 4413.4 4519.5 4532.9 4550.0 576.6 4144.9 4395.2 4443.2 4447.5 4454.2 4457.6 4469.5 4477.5 4500.2 4488.3 4491.0 4501.6 4504.3 4521.3 4362.9 4417.3 4433.1 4440.0 4444.6 4811.2 4815.3 4842.5 4848.9 4851.9 5057.8 5145.5 5202.9 5206.2 5232.7 5194.6 5227.5 5234.2 5239.0 5241.8 4845.0 4848.3 4868.3 4878.0 4932.1 5203.7 5225.1 5227.2 5352.7 5362.5 4998.4 5009.4 5020.6 5035.5 5071.6 5106.3 5108.7 5112.7 5133.8 5155.6 4973.3 5064.2 5074.8 5122.0 5144.2 5098.7 5103.5 5114.3 5121.7 5141.3 4253.7 4284.7 4303.0 4316.5 4349.4 3679.0 3685.1 3740.4 3761.5 3814.3 4430.5 4449.6 4464.3 4488.9 4491.1 5191.2 5211.6 5225.9 5239.7 5270.2 4498.5 4524.2 4526.4 4549.6 4574.8 4475.5 4590.0 4625.6 4628.9 4641.2 4934.7 4940.6 4951.7 4951.7 4977.7 5188.8 5220.0 5230.3 5242.9 5260.9 4764.2 4856.6 4915.1 4944.7 4977.5 5178.4 5179.3 5190.9 5192.9 5194.4 5196.9 5198.1 5205.6 5213.6 5255.9 4835.9 4932.2 4965.4 5012.3 5019.4 4960.6 4970.3 4979.6 4992.6 5014.6 4821.3 4918.2 4922.9 4935.0 4957.7 4956.9 4959.4 4967.9 4977.7 5008.1 4922.2 4930.8 4942.3 4943.4 4970.0 18:55:45 INFO - PROCESS | 3430 | 18:55:45 INFO - PROCESS | 3430 | [#1] ext.html Cycles:180 Average:50113.39 Median:35095.97 stddev:108117.23 (308.1%) stddev-sans-first:108356.58 18:55:45 INFO - PROCESS | 3430 | Values: 585.5 587.9 606.6 651.0 657.4 32429.8 33189.2 36164.8 36229.6 36241.1 37185.4 37887.2 37999.1 38040.6 38145.0 7511.8 7682.8 7684.4 7697.0 7700.4 7595.1 7606.7 7652.3 7685.7 7736.4 7703.4 7727.8 7750.3 7766.3 7775.7 7680.3 7700.3 7717.3 7729.8 7753.8 7613.9 7735.3 7758.4 7784.9 7799.8 34939.0 35077.8 35114.1 35126.6 35279.5 2045.1 2655.2 2893.5 2950.3 3014.8 27474.3 27657.2 27967.4 28036.3 28840.3 3347.2 3354.1 3384.6 3439.9 3496.0 221998.0 222296.0 223031.0 223042.0 223314.0 31741.2 31805.5 31884.7 32640.8 32901.8 33379.8 33594.7 33773.7 33791.2 33872.0 13395.3 13576.5 13580.3 13597.7 13631.0 11103.8 11209.6 11269.0 11276.8 11290.9 7698.9 7742.9 7744.8 7775.7 7796.6 3088.3 3157.0 3166.7 3183.2 3225.6 868.2 889.1 893.5 960.6 990.1 28236.2 28609.0 28825.3 29125.6 29284.7 908.3 951.9 956.6 958.3 998.2 15349.4 15384.8 15408.8 15596.4 15664.8 453972.0 463609.0 463905.0 692419.0 702712.0 49672.8 50703.2 50722.5 50739.7 50920.2 1179.9 1224.9 1236.5 1241.9 1249.7 27698.9 28227.3 29162.0 29252.4 29584.6 42467.4 42564.1 42936.4 43038.0 43052.6 335723.0 338349.0 340318.0 341761.0 343128.0 25411.4 25578.5 25709.9 25815.9 25930.6 41450.2 41824.2 41859.8 42110.2 42471.8 36353.6 36656.6 36806.0 37128.4 37722.8 35991.5 36022.5 36108.6 36188.3 36283.3 32003.2 34967.0 35455.3 35636.0 37964.0 31339.2 32670.8 32967.8 33028.8 33134.2 24866.6 25394.0 25550.7 25733.9 25824.2 18:55:45 INFO - PROCESS | 3430 | 18:55:45 INFO - PROCESS | 3430 | [#2] jquery.html Cycles:180 Average:24830.88 Median:4389.30 stddev:65628.21 (1495.2%) stddev-sans-first:65786.61 18:55:45 INFO - PROCESS | 3430 | Values: 367.8 372.9 375.3 383.0 383.7 16479.8 17713.8 17788.4 18545.1 18586.3 17112.1 17499.6 17702.6 17869.8 17900.3 5081.3 5255.5 5262.6 5281.1 5287.8 3664.0 4106.7 5201.8 6310.7 6328.1 6177.7 6212.1 6213.7 6232.3 6265.7 6098.1 6107.5 6241.4 6241.7 6271.9 5407.6 5408.5 5441.0 5445.7 5451.8 20930.9 21319.7 21467.1 21467.4 21615.6 1739.9 1995.6 2018.8 2109.7 2421.2 9383.7 9524.9 9641.2 9687.5 9753.8 1696.3 1705.7 1724.6 1776.4 1874.7 72994.0 74995.0 75047.6 75139.2 75181.2 10180.4 10245.3 10268.6 10348.1 10538.6 13954.0 13996.1 14035.6 14036.9 14062.6 6933.9 7084.7 7234.2 7354.5 7361.2 6836.5 6855.7 6895.9 7049.8 7106.6 4321.4 4386.4 4392.2 4456.3 4478.9 1841.0 1862.9 1878.8 1883.6 1910.5 382.3 814.7 848.5 879.8 910.8 10241.9 16779.2 16815.0 18170.4 19625.6 861.4 901.3 922.8 932.0 948.6 9761.4 10115.4 10122.2 10149.1 10324.9 387316.0 394603.0 395650.0 401731.0 404168.0 62085.7 80613.0 84102.0 85136.0 86250.6 932.6 937.4 947.1 963.3 967.7 14658.8 16584.0 16617.4 16828.2 16980.2 26881.5 29805.3 31389.9 33139.5 38387.6 51474.5 52500.5 53253.5 54074.7 55274.2 7790.8 7940.2 7980.7 7982.9 8049.4 8904.2 11818.6 12224.6 12285.4 12495.1 9674.6 9868.7 9922.7 10837.6 11068.5 9835.4 10358.7 10380.5 10523.2 10766.3 9768.8 10931.5 10958.8 11048.9 11294.0 7429.8 7508.0 7577.8 7640.5 7645.5 9781.0 9965.7 10322.2 10344.9 10792.5 18:55:45 INFO - PROCESS | 3430 | 18:55:45 INFO - PROCESS | 3430 | [#3] mootools.html Cycles:180 Average:5226.13 Median:4801.67 stddev:2985.62 (62.2%) stddev-sans-first:2979.93 18:55:45 INFO - PROCESS | 3430 | Values: 1369.2 1425.8 1501.0 1720.8 1744.5 7051.7 7687.2 7772.7 8195.4 8235.8 7824.0 8006.1 8026.6 8032.2 8113.7 2199.2 2243.7 2246.1 2260.0 2263.8 2184.6 2191.1 2233.7 2234.1 2250.5 2226.4 2229.2 2239.6 2241.2 2263.1 2142.4 2143.2 2163.8 2164.9 2171.8 2176.8 2183.1 2199.2 2213.2 2222.7 8143.3 8248.3 8274.5 8275.5 8286.9 4649.0 4774.3 4790.8 4791.2 4812.2 2796.3 2982.1 2989.5 2995.7 2998.0 875.6 899.6 921.9 925.7 925.9 10884.0 10919.1 10943.0 10966.2 10988.3 4013.6 4130.7 4215.8 4235.3 4241.8 9265.4 9357.3 9393.6 9426.7 9473.7 4732.9 4753.7 4758.6 4776.5 4777.5 3717.4 4209.7 4304.2 4317.1 4327.5 3722.3 3767.3 3881.4 3890.8 3982.2 1158.9 1213.3 1219.3 1232.5 1234.4 734.4 785.3 809.6 823.5 825.8 5025.4 5111.2 5153.4 5202.7 5287.1 859.7 888.0 898.1 907.4 912.4 3320.4 3323.7 3361.4 3387.7 3445.7 9772.5 9960.5 10050.5 10099.8 10115.2 9945.4 10004.2 10005.9 10009.5 10021.3 7471.6 7524.5 7593.0 7653.8 7663.2 5019.7 5086.5 5122.6 5136.5 5203.5 9209.4 9216.7 9226.7 9228.1 9474.5 9182.1 9489.8 9501.9 9530.0 9582.2 5732.8 6341.6 6493.2 6499.3 6623.0 7713.0 7763.0 7792.6 7794.1 7850.6 6582.4 6738.3 6872.0 6932.7 6960.2 6757.7 6802.6 6872.7 6957.8 7073.6 5846.4 5875.5 5919.4 5971.6 5983.3 4337.5 4347.9 4406.9 4416.5 4427.2 4534.5 4548.6 4643.1 4671.8 4673.1 18:55:45 INFO - PROCESS | 3430 | 18:55:45 INFO - PROCESS | 3430 | [#4] prototype.html Cycles:180 Average:4414.85 Median:5075.76 stddev:1278.36 (25.2%) stddev-sans-first:1244.13 18:55:45 INFO - PROCESS | 3430 | Values: 302.9 303.2 303.9 304.0 305.6 5080.9 5096.2 5097.5 5109.2 5131.7 4982.3 5029.4 5039.9 5050.9 5070.6 3805.9 3935.5 4001.9 4003.9 4013.2 3990.7 3992.7 3999.5 4014.1 4026.3 3979.5 3995.9 4001.5 4022.6 4037.5 3679.9 3924.6 3970.8 4007.8 4016.4 3421.6 3449.7 3452.9 3458.8 3466.3 4965.9 4980.3 4994.6 5008.6 5036.3 4364.9 4525.3 4525.7 4528.7 4560.5 5250.5 5312.8 5350.8 5363.2 5379.6 3869.5 3870.0 3878.4 3885.9 3891.5 5313.4 5518.2 5603.8 5616.6 5643.6 3825.1 3841.2 3859.8 3868.1 3870.6 3881.4 3884.1 3906.9 3909.2 3916.1 4465.4 4470.8 4473.0 4477.5 4479.2 5154.4 5321.2 5327.4 5391.8 5406.3 1369.3 1371.7 1388.8 1391.5 1392.1 896.8 908.3 924.3 924.3 940.6 4536.8 4597.9 4618.0 4663.2 4677.9 5368.8 5417.7 5462.7 5467.2 5471.2 4553.5 4599.6 4616.4 4617.6 4650.7 2866.7 2869.7 2888.2 2892.2 2899.8 5103.4 5119.8 5125.2 5131.7 5131.8 5301.7 5495.6 5502.9 5526.0 5539.7 5057.6 5098.3 5112.2 5142.0 5144.4 5320.0 5354.0 5358.7 5412.6 5443.2 5171.8 5311.4 5480.5 5482.8 5500.0 5245.5 5259.5 5266.4 5267.1 5286.5 3875.7 3885.9 3899.2 3901.2 3905.0 5414.6 5466.5 5530.0 5530.3 5540.4 5259.5 5304.2 5311.3 5356.7 5373.2 5086.7 5283.3 5297.5 5298.4 5315.8 5174.4 5182.9 5192.5 5225.1 5226.5 5125.1 5208.2 5400.3 5414.0 5431.4 5253.2 5284.3 5308.0 5309.9 5320.3 18:55:45 INFO - PROCESS | 3430 | 18:55:45 INFO - PROCESS | 3430 | [#5] yui.html Cycles:180 Average:17612.59 Median:533.00 stddev:25308.79 (4748.4%) stddev-sans-first:25347.45 18:55:45 INFO - PROCESS | 3430 | Values: 572.9 581.8 599.5 612.3 618.2 11100.6 11650.9 11717.9 11735.1 11737.1 9724.5 11683.8 11701.5 11745.5 11751.8 623.2 758.1 762.5 789.1 798.7 787.0 789.4 790.0 790.1 794.7 825.4 833.4 833.9 834.0 835.2 818.8 824.4 824.6 825.1 827.1 599.6 600.6 604.0 606.1 606.2 11771.9 11784.1 11793.6 11817.6 11884.8 12536.3 12954.2 12972.4 13019.2 13149.7 9889.2 9930.6 9931.1 10044.0 10178.1 3185.1 3222.2 3256.1 3266.7 3294.8 61388.0 61652.4 61713.7 62446.1 62776.0 9198.7 9499.4 9505.3 9544.7 9633.9 16882.8 17078.5 17137.4 17161.8 17194.1 6448.9 6488.4 6554.7 6656.2 6707.3 3625.3 3629.8 3692.2 3693.8 3704.8 2733.7 2805.9 2818.8 2820.0 2871.5 485.2 486.7 491.5 499.6 504.2 497.1 544.4 567.8 578.1 589.9 7557.0 7845.6 8084.9 8252.3 8694.4 521.6 629.6 640.5 645.2 645.7 3836.7 3981.2 4004.3 4015.1 4019.3 89752.6 94281.0 95567.0 95571.0 95739.0 81261.6 83541.6 87201.4 88096.6 88120.6 75149.0 75594.2 77021.0 77066.6 77500.6 7377.6 7397.5 7442.8 7563.9 7565.7 45315.3 45699.0 45823.5 46742.8 47247.8 56695.1 57590.4 62732.4 64960.0 66548.3 9356.8 9848.0 11293.5 11550.1 11684.4 13349.6 13376.4 13423.9 14231.7 14331.1 11932.3 12049.3 12348.9 12352.3 12449.7 12031.5 12096.2 12181.0 12632.4 12876.0 11154.9 11260.1 11514.3 11942.9 12219.6 10298.4 10697.1 10898.5 10933.9 10990.6 10099.1 10322.4 10392.1 10447.8 10455.1 18:55:45 INFO - PROCESS | 3430 | -------- Summary: end -------- 18:55:45 INFO - PROCESS | 3430 | 18:55:46 INFO - TEST-INFO | 3430: exit 0 18:55:46 INFO - TEST-OK | dromaeo_css | took 1122269ms 18:55:46 INFO - TEST-START | kraken 18:55:46 INFO - operating with platform_type : linux_ 18:55:46 INFO - Initialising browser for kraken test... 18:55:46 INFO - TEST-INFO | started process 3674 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpagVNIh/profile http://localhost:46355/getInfo.html) 18:55:52 INFO - PROCESS | 3674 | __metrics Screen width/height:1600/1200 18:55:52 INFO - PROCESS | 3674 | colorDepth:24 18:55:52 INFO - PROCESS | 3674 | Browser inner width/height: 1024/697 18:55:52 INFO - PROCESS | 3674 | __metrics 18:55:52 ERROR - PROCESS | 3674 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2952: TypeError: this.tabs is undefined 18:55:53 INFO - TEST-INFO | 3674: exit 0 18:55:53 INFO - Browser initialized. 18:55:53 INFO - Running cycle 1/1 for kraken test... 18:55:53 INFO - TEST-INFO | started process 3793 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpagVNIh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:56:05 INFO - PROCESS | 3793 | RSS: Main: 169623552 18:56:05 INFO - PROCESS | 3793 | 18:56:08 INFO - PROCESS | 3793 | Cycle 1(1): loaded http://localhost:46355/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46355/tests/kraken/driver.html?testName=audio-beat-detection) 18:56:09 INFO - PROCESS | 3793 | RSS: Main: 174133248 18:56:09 INFO - PROCESS | 3793 | 18:56:12 INFO - PROCESS | 3793 | Cycle 1(1): loaded http://localhost:46355/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46355/tests/kraken/driver.html?testName=audio-dft) 18:56:12 INFO - PROCESS | 3793 | RSS: Main: 174067712 18:56:12 INFO - PROCESS | 3793 | 18:56:15 INFO - PROCESS | 3793 | Cycle 1(1): loaded http://localhost:46355/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46355/tests/kraken/driver.html?testName=audio-fft) 18:56:16 INFO - PROCESS | 3793 | RSS: Main: 169320448 18:56:16 INFO - PROCESS | 3793 | 18:56:18 INFO - PROCESS | 3793 | Cycle 1(1): loaded http://localhost:46355/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46355/tests/kraken/driver.html?testName=audio-oscillator) 18:56:19 INFO - PROCESS | 3793 | RSS: Main: 170110976 18:56:19 INFO - PROCESS | 3793 | 18:56:21 INFO - PROCESS | 3793 | Cycle 1(1): loaded http://localhost:46355/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46355/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:56:22 INFO - PROCESS | 3793 | RSS: Main: 170565632 18:56:22 INFO - PROCESS | 3793 | 18:56:25 INFO - PROCESS | 3793 | Cycle 1(1): loaded http://localhost:46355/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46355/tests/kraken/driver.html?testName=imaging-darkroom) 18:56:26 INFO - PROCESS | 3793 | RSS: Main: 170844160 18:56:26 INFO - PROCESS | 3793 | 18:56:29 INFO - PROCESS | 3793 | Cycle 1(1): loaded http://localhost:46355/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46355/tests/kraken/driver.html?testName=imaging-desaturate) 18:56:30 INFO - PROCESS | 3793 | RSS: Main: 168009728 18:56:30 INFO - PROCESS | 3793 | 18:56:33 INFO - PROCESS | 3793 | Cycle 1(1): loaded http://localhost:46355/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46355/tests/kraken/driver.html?testName=json-parse-financial) 18:56:33 INFO - PROCESS | 3793 | RSS: Main: 169099264 18:56:33 INFO - PROCESS | 3793 | 18:56:35 INFO - PROCESS | 3793 | Cycle 1(1): loaded http://localhost:46355/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46355/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:56:36 INFO - PROCESS | 3793 | RSS: Main: 169717760 18:56:36 INFO - PROCESS | 3793 | 18:56:38 INFO - PROCESS | 3793 | Cycle 1(1): loaded http://localhost:46355/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46355/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:56:38 INFO - PROCESS | 3793 | RSS: Main: 169811968 18:56:38 INFO - PROCESS | 3793 | 18:56:40 INFO - PROCESS | 3793 | Cycle 1(1): loaded http://localhost:46355/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46355/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:56:41 INFO - PROCESS | 3793 | RSS: Main: 170147840 18:56:41 INFO - PROCESS | 3793 | 18:56:44 INFO - PROCESS | 3793 | Cycle 1(1): loaded http://localhost:46355/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46355/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:56:45 INFO - PROCESS | 3793 | RSS: Main: 170758144 18:56:45 INFO - PROCESS | 3793 | 18:56:47 INFO - PROCESS | 3793 | Cycle 1(1): loaded http://localhost:46355/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46355/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:56:48 INFO - PROCESS | 3793 | RSS: Main: 170254336 18:56:48 INFO - PROCESS | 3793 | 18:56:50 INFO - PROCESS | 3793 | Cycle 1(1): loaded http://localhost:46355/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46355/tests/kraken/driver.html?testName=ai-astar) 18:56:50 INFO - PROCESS | 3793 | RSS: Main: 171024384 18:56:50 INFO - PROCESS | 3793 | 18:56:50 INFO - PROCESS | 3793 | __start_tp_report 18:56:50 INFO - PROCESS | 3793 | _x_x_mozilla_page_load 18:56:50 INFO - PROCESS | 3793 | _x_x_mozilla_page_load_details 18:56:50 INFO - PROCESS | 3793 | |i|pagename|runs| 18:56:50 INFO - PROCESS | 3793 | |0;ai-astar;106;123;109;115;112;113;117;113;112;114 18:56:50 INFO - PROCESS | 3793 | |1;audio-beat-detection;153;121;148;170;124;144;143;123;178;126 18:56:50 INFO - PROCESS | 3793 | |2;audio-dft;166;161;164;166;169;161;162;162;162;161 18:56:50 INFO - PROCESS | 3793 | |3;audio-fft;76;79;74;154;79;77;77;75;161;77 18:56:50 INFO - PROCESS | 3793 | |4;audio-oscillator;85;85;142;86;86;85;137;84;85;145 18:56:50 INFO - PROCESS | 3793 | |5;imaging-gaussian-blur;118;118;118;119;117;117;121;118;119;117 18:56:50 INFO - PROCESS | 3793 | |6;imaging-darkroom;148;149;148;148;147;149;148;150;148;155 18:56:50 INFO - PROCESS | 3793 | |7;imaging-desaturate;95;96;95;95;95;96;96;95;96;95 18:56:50 INFO - PROCESS | 3793 | |8;json-parse-financial;63;65;65;64;65;65;64;65;73;64 18:56:50 INFO - PROCESS | 3793 | |9;json-stringify-tinderbox;64;65;64;66;65;64;64;64;64;65 18:56:50 INFO - PROCESS | 3793 | |10;stanford-crypto-aes;79;79;84;79;81;84;78;89;87;78 18:56:50 INFO - PROCESS | 3793 | |11;stanford-crypto-ccm;142;134;142;130;134;133;143;128;171;142 18:56:50 INFO - PROCESS | 3793 | |12;stanford-crypto-pbkdf2;166;171;171;168;167;173;170;170;169;166 18:56:50 INFO - PROCESS | 3793 | |13;stanford-crypto-sha256-iterative;67;69;68;66;66;66;68;68;66;69 18:56:50 INFO - PROCESS | 3793 | __end_tp_report 18:56:50 INFO - PROCESS | 3793 | __start_cc_report 18:56:50 INFO - PROCESS | 3793 | _x_x_mozilla_cycle_collect,1012 18:56:50 INFO - PROCESS | 3793 | __end_cc_report 18:56:50 INFO - PROCESS | 3793 | __startTimestamp1467770210550__endTimestamp 18:56:50 INFO - PROCESS | 3793 | 18:56:50 INFO - PROCESS | 3793 | ------- Summary: start ------- 18:56:50 INFO - PROCESS | 3793 | Number of tests: 14 18:56:50 INFO - PROCESS | 3793 | 18:56:50 INFO - PROCESS | 3793 | [#0] ai-astar Cycles:10 Average:113.40 Median:113.50 stddev:4.55 (4.0%) stddev-sans-first:3.96 18:56:50 INFO - PROCESS | 3793 | Values: 106.0 123.0 109.0 115.0 112.0 113.0 117.0 113.0 112.0 114.0 18:56:50 INFO - PROCESS | 3793 | 18:56:50 INFO - PROCESS | 3793 | [#1] audio-beat-detection Cycles:10 Average:143.00 Median:146.00 stddev:20.04 (13.7%) stddev-sans-first:20.93 18:56:50 INFO - PROCESS | 3793 | Values: 153.0 121.0 148.0 170.0 124.0 144.0 143.0 123.0 178.0 126.0 18:56:50 INFO - PROCESS | 3793 | 18:56:50 INFO - PROCESS | 3793 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.00 stddev:2.76 (1.7%) stddev-sans-first:2.76 18:56:50 INFO - PROCESS | 3793 | Values: 166.0 161.0 164.0 166.0 169.0 161.0 162.0 162.0 162.0 161.0 18:56:50 INFO - PROCESS | 3793 | 18:56:50 INFO - PROCESS | 3793 | [#3] audio-fft Cycles:10 Average:92.90 Median:77.00 stddev:34.12 (44.3%) stddev-sans-first:35.64 18:56:50 INFO - PROCESS | 3793 | Values: 76.0 79.0 74.0 154.0 79.0 77.0 77.0 75.0 161.0 77.0 18:56:50 INFO - PROCESS | 3793 | 18:56:50 INFO - PROCESS | 3793 | [#4] audio-oscillator Cycles:10 Average:102.00 Median:85.00 stddev:27.22 (32.0%) stddev-sans-first:28.16 18:56:50 INFO - PROCESS | 3793 | Values: 85.0 85.0 142.0 86.0 86.0 85.0 137.0 84.0 85.0 145.0 18:56:50 INFO - PROCESS | 3793 | 18:56:50 INFO - PROCESS | 3793 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.00 stddev:1.23 (1.0%) stddev-sans-first:1.30 18:56:50 INFO - PROCESS | 3793 | Values: 118.0 118.0 118.0 119.0 117.0 117.0 121.0 118.0 119.0 117.0 18:56:50 INFO - PROCESS | 3793 | 18:56:50 INFO - PROCESS | 3793 | [#6] imaging-darkroom Cycles:10 Average:149.00 Median:148.50 stddev:2.26 (1.5%) stddev-sans-first:2.37 18:56:50 INFO - PROCESS | 3793 | Values: 148.0 149.0 148.0 148.0 147.0 149.0 148.0 150.0 148.0 155.0 18:56:50 INFO - PROCESS | 3793 | 18:56:50 INFO - PROCESS | 3793 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 18:56:50 INFO - PROCESS | 3793 | Values: 95.0 96.0 95.0 95.0 95.0 96.0 96.0 95.0 96.0 95.0 18:56:50 INFO - PROCESS | 3793 | 18:56:50 INFO - PROCESS | 3793 | [#8] json-parse-financial Cycles:10 Average:65.30 Median:65.00 stddev:2.79 (4.3%) stddev-sans-first:2.83 18:56:50 INFO - PROCESS | 3793 | Values: 63.0 65.0 65.0 64.0 65.0 65.0 64.0 65.0 73.0 64.0 18:56:50 INFO - PROCESS | 3793 | 18:56:50 INFO - PROCESS | 3793 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:64.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 18:56:50 INFO - PROCESS | 3793 | Values: 64.0 65.0 64.0 66.0 65.0 64.0 64.0 64.0 64.0 65.0 18:56:50 INFO - PROCESS | 3793 | 18:56:50 INFO - PROCESS | 3793 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:82.50 stddev:3.97 (4.8%) stddev-sans-first:4.08 18:56:50 INFO - PROCESS | 3793 | Values: 79.0 79.0 84.0 79.0 81.0 84.0 78.0 89.0 87.0 78.0 18:56:50 INFO - PROCESS | 3793 | 18:56:50 INFO - PROCESS | 3793 | [#11] stanford-crypto-ccm Cycles:10 Average:139.90 Median:142.00 stddev:12.23 (8.6%) stddev-sans-first:12.95 18:56:50 INFO - PROCESS | 3793 | Values: 142.0 134.0 142.0 130.0 134.0 133.0 143.0 128.0 171.0 142.0 18:56:50 INFO - PROCESS | 3793 | 18:56:50 INFO - PROCESS | 3793 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.10 Median:170.00 stddev:2.33 (1.4%) stddev-sans-first:2.19 18:56:50 INFO - PROCESS | 3793 | Values: 166.0 171.0 171.0 168.0 167.0 173.0 170.0 170.0 169.0 166.0 18:56:50 INFO - PROCESS | 3793 | 18:56:50 INFO - PROCESS | 3793 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:68.00 stddev:1.25 (1.8%) stddev-sans-first:1.32 18:56:50 INFO - PROCESS | 3793 | Values: 67.0 69.0 68.0 66.0 66.0 66.0 68.0 68.0 66.0 69.0 18:56:50 INFO - PROCESS | 3793 | -------- Summary: end -------- 18:56:50 INFO - PROCESS | 3793 | 18:56:51 INFO - TEST-INFO | 3793: exit 0 18:56:51 INFO - TEST-OK | kraken | took 64989ms 18:56:51 INFO - SUITE-END | took 1187s 18:56:51 INFO - Completed test suite (00:19:47) 18:56:51 INFO - javascript benchmark 18:56:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6412.556048219311, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2627.8817453214606, 2647.1529110684583, 2676.5583678693015, 2677.812553121281, 2682.7183145769695, 4752.477227504976, 4755.857324280277, 4762.047590481904, 4825.662203645747, 4886.1204983103025, 4756.310335001423, 4817.566419022287, 4818.229083346665, 4838.104950584136, 4844.442889067758, 4392.363107349441, 4413.3821265022925, 4519.52544982777, 4532.932006019896, 4549.954500455003, 576.5759319795426, 4144.937825932613, 4395.208862404766, 4443.15580039793, 4447.510773814878, 4454.175977444183, 4457.6433885289425, 4469.508354081048, 4477.529859364752, 4500.234960056766, 4488.304312831517, 4491.0, 4501.572350626685, 4504.301833215824, 4521.253993091136, 4362.890927726832, 4417.293233082692, 4433.113377324548, 4440.023194897118, 4444.577765112309, 4811.182099043171, 4815.253635686439, 4842.5157484251295, 4848.903021939542, 4851.854444366674, 5057.848264552033, 5145.536901678867, 5202.869928251786, 5206.24509446132, 5232.6860388376435, 5194.6104042196985, 5227.503387178212, 5234.16253399458, 5238.973805130988, 5241.764120614544, 4845.030993801254, 4848.321235027099, 4868.294097355899, 4878.02455401485, 4932.136876046749, 5203.687778733288, 5225.085610018232, 5227.163653815372, 5352.732363381893, 5362.51737343641, 4998.400191976986, 5009.44896061433, 5020.623453241022, 5035.496450355008, 5071.594272458195, 5106.259592359087, 5108.7190204538365, 5112.693238405707, 5133.845984620468, 5155.561777248976, 4973.303737476756, 5064.215046667772, 5074.797008119708, 5121.974390128025, 5144.151215049475, 5098.668586541937, 5103.489651034867, 5114.258432527263, 5121.667091639031, 5141.25451809493, 4253.744775313429, 4284.700070995063, 4303.0, 4316.525182229952, 4349.391085248068, 3678.981605092011, 3685.0787303174206, 3740.401535754266, 3761.4733937248807, 3814.256220037066, 4430.4683437987005, 4449.644028477714, 4464.263396539534, 4488.887777805516, 4491.079328737601, 5191.169412893994, 5211.609129315317, 5225.869353266199, 5239.711815850089, 5270.183121616155, 4498.482674492409, 4524.16302983949, 4526.4115664964, 4549.636029117729, 4574.839880604163, 4475.507694153641, 4589.954100458953, 4625.5836974671765, 4628.930566041512, 4641.234196357564, 4934.654574179773, 4940.629452790983, 4951.653384263211, 4951.702897826142, 4977.726225057584, 5188.766505507186, 5219.973900130475, 5230.293910322058, 5242.895142097213, 5260.868478288074, 4764.190087685171, 4856.611471082376, 4915.066137433876, 4944.703317800943, 4977.527134922177, 5178.404483484447, 5179.326687530597, 5190.8961820764125, 5192.922106168335, 5194.35070616173, 5196.870078248074, 5198.0643484173215, 5205.58355331565, 5213.60897932649, 5255.868603284948, 4835.879103022453, 4932.186189278729, 4965.354503914468, 5012.273220383097, 5019.422766381913, 4960.603151747924, 4970.279309500174, 4979.551840334388, 4992.600591952708, 5014.598832093497, 4821.349117869043, 4918.163912135017, 4922.901541969212, 4935.0, 4957.702537847741, 4956.925646115384, 4959.404871415453, 4967.925481117713, 4977.651564390458, 5008.148614735576, 4922.163232250455, 4930.778114984762, 4942.28336891156, 4943.406791185081, 4970.005998800327], "value": 4706.436747872141, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.508173134567, 587.9265091863518, 606.6087373644, 650.9804705858826, 657.355791324502, 32429.83785081074, 33189.17027074324, 36164.819175904086, 36229.63770362295, 36241.09397265063, 37185.44221836675, 37887.24225515488, 37999.05002374942, 38040.619593804055, 38145.0, 7511.812204694886, 7682.846343073135, 7684.38524918008, 7696.961515192416, 7700.383969282444, 7595.088589369256, 7606.695732170707, 7652.349550288232, 7685.730999415022, 7736.419768517356, 7703.4222433317445, 7727.845443091135, 7750.2637249461495, 7766.262205090507, 7775.6500957456765, 7680.308772210527, 7700.345470634975, 7717.344025757818, 7729.768106956801, 7753.767386978371, 7613.885791713129, 7735.265149810759, 7758.418118641124, 7784.922150778533, 7799.8440031199625, 34939.0, 35077.824610876785, 35114.122146946276, 35126.64873351285, 35279.4708079379, 2045.110376986001, 2655.150351887397, 2893.4647090288363, 2950.336174360773, 3014.788964772467, 27474.313142171606, 27657.170284891487, 27967.440651186862, 28036.299092522648, 28840.278993025342, 3347.2468694543777, 3354.060862958351, 3384.5769278840144, 3439.8796042138656, 3496.0385893879134, 221998.0, 222296.0, 223031.0, 223042.0, 223314.0, 31741.20646983844, 31805.52291715626, 31884.681153188172, 32640.836795816344, 32901.83549082239, 33379.83310083434, 33594.664053359644, 33773.66226337705, 33791.15522111967, 33872.0, 13395.330233488286, 13576.456941722417, 13580.320983950764, 13597.728045439037, 13631.0, 11103.777924441465, 11209.551617935354, 11269.0, 11276.774464510663, 11290.887091129149, 7698.884516732253, 7742.8838567421535, 7744.845103097907, 7775.650095745705, 7796.649150788228, 3088.2896933705374, 3157.0371036833526, 3166.746660267173, 3183.1564635371647, 3225.580674512298, 868.2142660891903, 889.0886840988039, 893.5442924108621, 960.6013504395597, 990.1336330710628, 28236.15291541257, 28609.0, 28825.27936801555, 29125.56311655327, 29284.707152928626, 908.2869947091501, 951.9381240219363, 956.5695437053215, 958.2717134977468, 998.1964518562627, 15349.386024559117, 15384.846151538566, 15408.845911540966, 15596.376144954302, 15664.765028524582, 453972.0, 463609.0, 463905.0, 692419.0, 702712.0, 49672.751636241584, 50703.239451408255, 50722.492775071776, 50739.68712659391, 50920.23619645708, 1179.8584169899666, 1224.8530176378893, 1236.4992178167856, 1241.85097788266, 1249.731307768834, 27698.86150569315, 28227.294317642223, 29162.0, 29252.414951701274, 29584.55623165611, 42467.3629895558, 42564.1487170261, 42936.35595466133, 43038.0, 43052.56947430611, 335723.0, 338349.0, 340318.0, 341761.0, 343128.0, 25411.36471588225, 25578.488430231664, 25709.871450642626, 25815.870920645277, 25930.61104083478, 41450.170996580506, 41824.163516728884, 41859.7907010463, 42110.157796844505, 42471.78764106159, 36353.63646363608, 36656.633433666386, 36806.0, 37128.443073354465, 37722.81138594289, 35991.46012809758, 36022.4596631056, 36108.63891361053, 36188.27623447464, 36283.27433451264, 32003.199920001254, 34967.0, 35455.29089418145, 35636.0, 37964.0, 31339.216519587193, 32670.83664581662, 32967.83516082404, 33028.83485582557, 33134.183594394744, 24866.627000595367, 25394.0, 25550.744492554837, 25733.871330643226, 25824.22527324183], "value": 16296.24137018677, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.83631284078564, 372.9123655940853, 375.29819238024896, 383.0423940149626, 383.7160501229091, 16479.75280370794, 17713.83803150748, 17788.377406790765, 18545.07274636266, 18586.256549738013, 17112.14439278034, 17499.562510937234, 17702.557436064104, 17869.82130178698, 17900.28398864044, 5081.288619593269, 5255.500727430907, 5262.552683021948, 5281.075811732951, 5287.814926477574, 3664.0050348110044, 4106.650934670542, 5201.817936372227, 6310.716017779211, 6328.08242804793, 6177.722002509875, 6212.1303017577575, 6213.658248796337, 6232.283287421937, 6265.686715664221, 6098.115773212904, 6107.4808641265545, 6241.407066328691, 6241.687915604201, 6271.937280627204, 5407.648502847303, 5408.513233808976, 5441.0, 5445.673259604437, 5451.836444906619, 20930.895345523328, 21319.68020479694, 21467.141314347406, 21467.355979320644, 21615.567688646297, 1739.9130043497773, 1995.5909038647042, 2018.7880272571463, 2109.69409435631, 2421.1889017179265, 9383.671571495033, 9524.90475095254, 9641.180499657537, 9687.450007998757, 9753.756156096084, 1696.2706036404466, 1705.7185564381862, 1724.6378260565295, 1776.3516316544496, 1874.6813041782793, 72994.0, 74995.0, 75047.62476187639, 75139.24860751377, 75181.24818751797, 10180.389176649425, 10245.334053286513, 10268.589256429808, 10348.068673819242, 10538.63114790994, 13954.0, 13996.090254133449, 14035.649108772363, 14036.929815350857, 14062.648433789238, 6933.930660693329, 7084.716611335592, 7234.204237533867, 7354.485186036926, 7361.190269070398, 6836.487263455261, 6855.725770969106, 6895.862082758316, 7049.753258636026, 7106.644667766591, 4321.416608757841, 4386.363977223285, 4392.231359512072, 4456.264716321771, 4478.910421791546, 1841.0242571437159, 1862.9347972820885, 1878.7557617509635, 1883.5950270691867, 1910.5032691500032, 382.2698645586971, 814.6619153051417, 848.4866655673352, 879.8284334554828, 910.7677542226822, 10241.94879025615, 16779.244933978, 16815.0, 18170.364037258896, 19625.626206165718, 861.3539845116163, 901.3330135699666, 922.7785331520387, 932.021377553566, 948.6395169835419, 9761.36551124189, 10115.443650599287, 10122.240831937634, 10149.137323327599, 10324.948375258076, 387316.0, 394603.0, 395650.0, 401731.0, 404168.0, 62085.68957155276, 80613.0, 84102.0, 85135.99999999876, 86250.56874715711, 932.6222879733718, 937.3906960475609, 947.1475671895349, 963.349738926222, 967.709687093869, 14658.780118298448, 16584.0, 16617.41839035628, 16828.15859207059, 16980.235889385254, 26881.462370752866, 29805.254868628457, 31389.90135345343, 33139.50290745689, 38387.6161238384, 51474.48525514697, 52500.47499525108, 53253.4674653264, 54074.72962635162, 55274.170887437525, 7790.766277011472, 7940.245676660708, 7980.720674776355, 7982.920170798217, 8049.436539442183, 8904.19862212404, 11818.586349477728, 12224.572139975058, 12285.447154877873, 12495.062870284582, 9674.613015479303, 9868.703938881845, 9922.702318930444, 10837.620683276047, 11068.501917413574, 9835.409875407498, 10358.741031473972, 10380.532876020749, 10523.158147348347, 10766.300190487593, 9768.80462390734, 10931.4888273168, 10958.780824383628, 11048.889511104786, 11294.0, 7429.8142546436775, 7508.0, 7577.772666820004, 7640.465167438226, 7645.541267523967, 9781.0, 9965.701028969142, 10322.225833062701, 10344.896551034695, 10792.460376981277], "value": 8381.424163867481, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1369.1511263016928, 1425.750493663609, 1500.9924950375246, 1720.7849018872641, 1744.4940967119535, 7051.682674279657, 7687.154413014564, 7772.650230739616, 8195.426320157583, 8235.752927412172, 7824.0, 8006.0793008804, 8026.598670066503, 8032.156623554531, 8113.675452981888, 2199.186301068603, 2243.719535058118, 2246.1240116354634, 2259.9661005084936, 2263.8302127340517, 2184.628613135763, 2191.1125993972387, 2233.7207849018873, 2234.0505285253785, 2250.549890021994, 2226.4100013496354, 2229.230915334207, 2239.6304609739373, 2241.204372447774, 2263.0608297556496, 2142.4001279641725, 2143.228437762404, 2163.772803855596, 2164.8701077935298, 2171.8489200723643, 2176.8258539316816, 2183.1376606240606, 2199.1533259694975, 2213.2143089203423, 2222.733272007353, 8143.307818835406, 8248.340132789423, 8274.503529788231, 8275.462094963808, 8286.917130828675, 4648.976755116237, 4774.331593576902, 4790.8323208687525, 4791.161546729309, 4812.181929072066, 2796.286946828566, 2982.0606508949827, 2989.5216765317446, 2995.715407036328, 2997.970020299813, 875.6165258890937, 899.6131663384742, 921.8617207418873, 925.7086364521522, 925.8611208318739, 10884.020438160524, 10919.12646988239, 10943.0, 10966.232363734542, 10988.285761425483, 4013.57857424972, 4130.690198235145, 4215.78921053946, 4235.25882970479, 4241.766702831374, 9265.44407335562, 9357.344985851061, 9393.624255029723, 9426.670066547775, 9473.66842160521, 4732.881677958009, 4753.714777113384, 4758.643101767381, 4776.546228108394, 4777.546133117417, 3717.368047431943, 4209.705320627527, 4304.225239456865, 4317.0934103838545, 4327.545607711145, 3722.2927643748144, 3767.3030489359007, 3881.437191607258, 3890.7665540067687, 3982.203559288154, 1158.8841115888345, 1213.2780995307953, 1219.3171823778712, 1232.4761976160096, 1234.388977456147, 734.4418242136015, 785.344237561631, 809.5709274084744, 823.5264722784423, 825.8141918068386, 5025.39695236574, 5111.182210846247, 5153.3558305211845, 5202.713850738246, 5287.101192797234, 859.6546404876349, 887.9556022198864, 898.1377877237794, 907.3739120007306, 912.3932584831146, 3320.369129865318, 3323.7174840138377, 3361.4453615153716, 3387.7459190560808, 3445.7423040590006, 9772.462514561625, 9960.501974901226, 10050.497475126214, 10099.848502272473, 10115.241356898263, 9945.353552019096, 10004.19966402686, 10005.899941000642, 10009.499525023719, 10021.29850910444, 7471.589062601501, 7524.510906791041, 7593.0, 7653.770386888402, 7663.157052724196, 5019.673721208256, 5086.465921078381, 5122.641415101056, 5136.5377116059735, 5203.453637368022, 9209.355345125778, 9216.723498295061, 9226.677066302647, 9228.123328283802, 9474.52627368615, 9182.127697868691, 9489.810203795747, 9501.857472138061, 9529.952350238205, 9582.185514231369, 5732.799352022659, 6341.587796793194, 6493.22081350241, 6499.285078641251, 6623.0, 7713.0, 7762.961185194038, 7792.6103694816165, 7794.142644309008, 7850.568218748023, 6582.440492558187, 6738.292479289604, 6872.037914691847, 6932.7226910923, 6960.199577048705, 6757.729690812313, 6802.557833740791, 6872.656367181721, 6957.756478523227, 7073.610951397723, 5846.386129456346, 5875.471207591338, 5919.408059194218, 5971.58198926071, 5983.252093488314, 4337.501187363494, 4347.891302717458, 4406.942333839919, 4416.470023597189, 4427.247367947392, 4534.501204867528, 4548.613367863769, 4643.071385722937, 4671.813127474863, 4673.135469938073], "value": 4189.477061352723, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.86825231024505, 303.20106519321587, 303.8966751304556, 303.96200474940633, 305.57982773686194, 5080.949190508099, 5096.210087436449, 5097.5157360050825, 5109.208072748721, 5131.743412829353, 4982.302477653131, 5029.421616514102, 5039.949600503994, 5050.873728156798, 5070.569001634856, 3805.885823425295, 3935.48838650975, 4001.899952501182, 4003.879883603482, 4013.157236980223, 3990.7206495545324, 3992.7005474589378, 3999.520057593093, 4014.116894283253, 4026.255142798592, 3979.5224573051128, 3995.900102497432, 4001.4598029266112, 4022.557518672944, 4037.454943582623, 3679.9264014719824, 3924.646781789653, 3970.7816070116132, 4007.839686412555, 4016.3975403689387, 3421.5723034620673, 3449.6550344965303, 3452.9309413811584, 3458.792472451661, 3466.254755227613, 4965.925511117336, 4980.2778597103215, 4994.55049045584, 5008.574271186953, 5036.320096786923, 4364.912701745948, 4525.2533332000185, 4525.660575456821, 4528.682992190548, 4560.521145279731, 5250.5274525292525, 5312.814051508179, 5350.759215835258, 5363.195520671891, 5379.569634429236, 3869.4776205212497, 3869.961300386988, 3878.3794592865006, 3885.922281554353, 3891.4746509221177, 5313.352860613222, 5518.19986102013, 5603.775848966036, 5616.550675945915, 5643.6049476536655, 3825.139343647713, 3841.2317536492815, 3859.7684138951754, 3868.0909986153233, 3870.59358767331, 3881.378979363288, 3884.1454879926373, 3906.882793516199, 3909.2181563687377, 3916.099297161669, 4465.352523884084, 4470.798814053375, 4472.955270447319, 4477.462704475483, 4479.216137175981, 5154.433012368637, 5321.175217841241, 5327.387350454747, 5391.81128660495, 5406.324209473816, 1369.2674419185687, 1371.7448534590937, 1388.7916812478209, 1391.5060153645513, 1392.1090502078678, 896.7714231502882, 908.2824568590739, 924.255973940984, 924.3344791749929, 940.6002448959165, 4536.77316134192, 4597.885052873638, 4617.953820461819, 4663.160631086437, 4677.859664210079, 5368.758405871745, 5417.702026388508, 5462.699551524624, 5467.20725494801, 5471.151971444432, 4553.4991150973365, 4599.6090332321455, 4616.407339467878, 4617.561331673485, 4650.674452788272, 2866.656001279818, 2869.6556413230546, 2888.1913064342016, 2892.248015515981, 2899.782516311243, 5103.362079740033, 5119.846404607868, 5125.231215317732, 5131.692098474104, 5131.820386286462, 5301.6818990860675, 5495.587830912697, 5502.9174562380795, 5525.972370138124, 5539.695316757537, 5057.620678449058, 5098.311727916758, 5112.156494178419, 5142.023015627019, 5144.408393034774, 5319.973400132974, 5354.0, 5358.732063396893, 5412.594055445778, 5443.210734443563, 5171.7934880374405, 5311.362636483646, 5480.479354461319, 5482.80810171642, 5500.0, 5245.501677340647, 5259.47405259471, 5266.447023062523, 5267.13092339775, 5286.497782710637, 3875.689944804465, 3885.9417108743955, 3899.2006638638445, 3901.219756048745, 3905.00844569266, 5414.566834653139, 5466.480684334982, 5530.004599172187, 5530.308711411074, 5540.390557038803, 5259.500347466985, 5304.177852432879, 5311.256424100707, 5356.705381204071, 5373.247745315737, 5086.745662716923, 5283.339582552181, 5297.549708274686, 5298.364196296469, 5315.760790764348, 5174.379074511083, 5182.870428239325, 5192.480751924777, 5225.1378522543355, 5226.503482169188, 5125.128728116304, 5208.244804503402, 5400.324959380077, 5413.9729301353245, 5431.37539182999, 5253.23828044939, 5284.26020357158, 5307.9734601326745, 5309.920351194813, 5320.255164277081], "value": 4006.925540391343, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.9398413166617, 581.7934633205209, 599.4515018757837, 612.2713970375253, 618.15313021161, 11100.55597776089, 11650.941745291282, 11717.882821171796, 11735.11986601005, 11737.06103511719, 9724.465154416504, 11683.766324673501, 11701.531938722463, 11745.47145378458, 11751.823722644145, 623.2334228898458, 758.1395116542709, 762.4662736084736, 789.0846617923211, 798.6805277888833, 787.0122995640463, 789.4394979564516, 790.0322105420871, 790.0795573157264, 794.6860989908982, 825.3974598543067, 833.4166083741375, 833.8790875323105, 833.9666413343489, 835.1940377535677, 818.7666515043214, 824.3858325547445, 824.6371596497522, 825.0965193113531, 827.1191181391798, 599.5802937943413, 600.6006006006, 604.0425924909024, 606.1302031584646, 606.1786279591134, 11771.882281177164, 11784.116191285688, 11793.646190614296, 11817.586384476503, 11884.821727674092, 12536.310502922335, 12954.157979731288, 12972.351382430936, 13019.153755005895, 13149.737005259842, 9889.159421449185, 9930.602775889029, 9931.106200441922, 10044.045815647502, 10178.083972442442, 3185.108169712461, 3222.1783445221554, 3256.1045712429036, 3266.657001014883, 3294.802311861296, 61388.0, 61652.383476165116, 61713.691431543004, 62446.0633090504, 62776.0, 9198.678046268482, 9499.373530542358, 9505.334626576074, 9544.665936692183, 9633.855492167622, 16882.831171688125, 17078.48764537066, 17137.400190993256, 17161.828381716274, 17194.1402929853, 6448.903266451007, 6488.448481878999, 6554.737810487527, 6656.2345330287635, 6707.262201157869, 3625.2930678517437, 3629.8185090745355, 3692.2246328270826, 3693.759905606127, 3704.833282502294, 2733.685626152978, 2805.9158225253277, 2818.760405365526, 2819.957700634492, 2871.5261981772774, 485.1921550618252, 486.72013592184635, 491.46921324968946, 499.5928318420548, 504.208392823264, 497.14242930944556, 544.3957207499673, 567.7842419880419, 578.1328007988018, 589.9262592175978, 7556.962215188889, 7845.5684937329, 8084.878726819103, 8252.298554622805, 8694.435281534541, 521.5983692556711, 629.5813284165978, 640.4620119099885, 645.2321737132797, 645.6900687669945, 3836.6558460956526, 3981.163955569305, 4004.2592120457807, 4015.1367455996515, 4019.2765302245875, 89752.5512372434, 94281.0, 95567.0, 95571.0, 95738.98029253527, 81261.59369203117, 83541.58229208815, 87201.40784513699, 88096.559517202, 88120.55939720261, 75149.0, 75594.24405755982, 77021.0, 77066.61466692743, 77500.61249693828, 7377.631118444164, 7397.482176247611, 7442.806808595193, 7563.886541701989, 7565.659545320584, 45315.32027019531, 45699.0, 45823.541764581925, 46742.76628616835, 47247.76376118098, 56695.14957275562, 57590.42409576018, 62732.37267627265, 64960.0, 66548.33451665421, 9356.812863742824, 9847.950760246153, 11293.522641518692, 11550.133739969368, 11684.357360345262, 13349.599512014654, 13376.398062087035, 13423.865761342653, 14231.715365692835, 14331.06848054873, 11932.28406295625, 12049.33728644933, 12348.938255308665, 12352.320622365856, 12449.688757780765, 12031.518739250681, 12096.153269271066, 12181.0, 12632.43154058088, 12876.0, 11154.888451115385, 11260.09919206478, 11514.251573647685, 11942.940285298519, 12219.633410997685, 10298.433586152834, 10697.090747286567, 10898.455077246264, 10933.890661093605, 10990.615328463466, 10099.141572966086, 10322.432266225429, 10392.116670083127, 10447.791044179226, 10455.11131553796], "value": 6442.799668222397, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1565.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 123.0, 109.0, 115.0, 112.0, 113.0, 117.0, 113.0, 112.0, 114.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 121.0, 148.0, 170.0, 124.0, 144.0, 143.0, 123.0, 178.0, 126.0], "value": 143.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 161.0, 164.0, 166.0, 169.0, 161.0, 162.0, 162.0, 162.0, 161.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 79.0, 74.0, 154.0, 79.0, 77.0, 77.0, 75.0, 161.0, 77.0], "value": 92.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 142.0, 86.0, 86.0, 85.0, 137.0, 84.0, 85.0, 145.0], "value": 102.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 119.0, 117.0, 117.0, 121.0, 118.0, 119.0, 117.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 148.0, 148.0, 147.0, 149.0, 148.0, 150.0, 148.0, 155.0], "value": 149.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 96.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, 65.0, 64.0, 65.0, 65.0, 64.0, 65.0, 73.0, 64.0], "value": 65.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 66.0, 65.0, 64.0, 64.0, 64.0, 64.0, 65.0], "value": 64.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 84.0, 79.0, 81.0, 84.0, 78.0, 89.0, 87.0, 78.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 134.0, 142.0, 130.0, 134.0, 133.0, 143.0, 128.0, 171.0, 142.0], "value": 139.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 171.0, 171.0, 168.0, 167.0, 173.0, 170.0, 170.0, 169.0, 166.0], "value": 169.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 68.0, 66.0, 66.0, 66.0, 68.0, 68.0, 66.0, 69.0], "value": 67.3, "unit": "score"}]}]} 18:56:51 INFO - Return code: 0 18:56:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:56:51 ERROR - # TBPL SUCCESS # 18:56:51 INFO - Running post-action listener: _resource_record_post_action 18:56:51 INFO - ##### 18:56:51 INFO - ##### Finished run-tests step (success) 18:56:51 INFO - ##### 18:56:51 INFO - Running post-run listener: _resource_record_post_run 18:56:51 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 7778304; Write bytes: 421675008; Read time: 1864; Write time: 653656 18:56:51 INFO - TinderboxPrint: CPU usage
13.3% 18:56:51 INFO - TinderboxPrint: I/O read bytes / time
7,778,304 / 1,864 18:56:51 INFO - TinderboxPrint: I/O write bytes / time
421,675,008 / 653,656 18:56:51 INFO - TinderboxPrint: CPU idle
8,327.5 (86.7%) 18:56:51 INFO - TinderboxPrint: CPU user
1,219.4 (12.7%) 18:56:51 INFO - TinderboxPrint: Swap in / out
0 / 0 18:56:51 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 4694016; Read time: 0; Write time: 540 18:56:51 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 5541888; Write bytes: 416980992; Read time: 1676; Write time: 653116 18:56:52 INFO - Running post-run listener: _upload_blobber_files 18:56:52 INFO - Blob upload gear active. 18:56:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:56:52 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 18:56:52 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'] 18:56:52 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 18:56:52 INFO - (blobuploader) - INFO - Open directory for files ... 18:56:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:56:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:56:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:56:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:56:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:56:57 INFO - (blobuploader) - INFO - Done attempting. 18:56:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:56:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:56:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:56:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:56:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:56:57 INFO - (blobuploader) - INFO - Done attempting. 18:56:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:56:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:56:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:56:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:56:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:56:59 INFO - (blobuploader) - INFO - Done attempting. 18:56:59 INFO - (blobuploader) - INFO - Iteration through files over. 18:56:59 INFO - Return code: 0 18:56:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:56:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:56:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1da0fdbf560343d88d1cf00b8935eec7962bdf99349554d33f238a97830b57201ace8566b253448dba87841c6ede647fb9bc4b9a1d40963f48d4ed5236d2d193", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2d8aebe204e3a87409f1956066f8d7f67944776ec101b2e0d3cece47a47ffb05df526954e1f8d24c952dbf30dba84ab10bd5c9a78c37b5566e8b5e9917662550", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f1e12a554ed7acbd911d08df537cfcf3858f7940887d83b54529990fd35c024a9ed9c477ba1504a9fa0006d75ef9213967b16595126f9e8cd94903acb041ac29"} 18:56:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:56:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:56:59 INFO - Contents: 18:56:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1da0fdbf560343d88d1cf00b8935eec7962bdf99349554d33f238a97830b57201ace8566b253448dba87841c6ede647fb9bc4b9a1d40963f48d4ed5236d2d193", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2d8aebe204e3a87409f1956066f8d7f67944776ec101b2e0d3cece47a47ffb05df526954e1f8d24c952dbf30dba84ab10bd5c9a78c37b5566e8b5e9917662550", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f1e12a554ed7acbd911d08df537cfcf3858f7940887d83b54529990fd35c024a9ed9c477ba1504a9fa0006d75ef9213967b16595126f9e8cd94903acb041ac29"} 18:56:59 INFO - Running post-run listener: copy_logs_to_upload_dir 18:56:59 INFO - Copying logs to upload dir... 18:56:59 INFO - mkdir: /builds/slave/test/build/upload/logs 18:56:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.480167 ========= master_lag: 1.34 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-07-05 18:57:00.382633) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 18:57:00.387011) ========= 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=5bd038846534b2fdfa68eeae000001e2-1467764471.942659-1642918687 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/1da0fdbf560343d88d1cf00b8935eec7962bdf99349554d33f238a97830b57201ace8566b253448dba87841c6ede647fb9bc4b9a1d40963f48d4ed5236d2d193", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2d8aebe204e3a87409f1956066f8d7f67944776ec101b2e0d3cece47a47ffb05df526954e1f8d24c952dbf30dba84ab10bd5c9a78c37b5566e8b5e9917662550", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f1e12a554ed7acbd911d08df537cfcf3858f7940887d83b54529990fd35c024a9ed9c477ba1504a9fa0006d75ef9213967b16595126f9e8cd94903acb041ac29"} build_url:https://queue.taskcluster.net/v1/task/blVkHgK5T3u2Z1wnwUE_gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011155 build_url: 'https://queue.taskcluster.net/v1/task/blVkHgK5T3u2Z1wnwUE_gg/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/1da0fdbf560343d88d1cf00b8935eec7962bdf99349554d33f238a97830b57201ace8566b253448dba87841c6ede647fb9bc4b9a1d40963f48d4ed5236d2d193", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2d8aebe204e3a87409f1956066f8d7f67944776ec101b2e0d3cece47a47ffb05df526954e1f8d24c952dbf30dba84ab10bd5c9a78c37b5566e8b5e9917662550", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f1e12a554ed7acbd911d08df537cfcf3858f7940887d83b54529990fd35c024a9ed9c477ba1504a9fa0006d75ef9213967b16595126f9e8cd94903acb041ac29"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 18:57:00.418548) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 18:57:00.418898) ========= 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=5bd038846534b2fdfa68eeae000001e2-1467764471.942659-1642918687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004342 ========= master_lag: 0.44 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 18:57:00.863941) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 18:57:00.864272) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 18:57:00.864739) ========= ========= Total master_lag: 1.85 =========