builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-006 starttime: 1467928020.56 results: success (0) buildid: 20160707141926 builduid: 2ec022409c754ff0a2e20e32d6ed5d5c revision: 8e07e417a5bb24c48486e560ec5823f17dbe3403 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 14:47:00.556403) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 14:47:00.556980) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 14:47:00.557273) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 14:47:00.572483) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 14:47:00.572846) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1467927894.647237-886956406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-07 14:47:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 67.6M=0s 2016-07-07 14:47:00 (67.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116527 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 14:47:00.706102) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 14:47:00.706729) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1467927894.647237-886956406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014417 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 14:47:00.756856) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-07 14:47:00.757270) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8e07e417a5bb24c48486e560ec5823f17dbe3403 --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 8e07e417a5bb24c48486e560ec5823f17dbe3403 --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=e31afd3c0f0de4e86ebe4d94000001b5-1467927894.647237-886956406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-07 14:47:00,947 truncating revision to first 12 chars 2016-07-07 14:47:00,947 Setting DEBUG logging. 2016-07-07 14:47:00,947 attempt 1/10 2016-07-07 14:47:00,947 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8e07e417a5bb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-07 14:47:01,669 unpacking tar archive at: fx-team-8e07e417a5bb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.067984 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-07 14:47:01.839634) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 14:47:01.839994) ========= script_repo_revision: 8e07e417a5bb24c48486e560ec5823f17dbe3403 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 14:47:01.840482) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 14:47:01.840781) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 14:47:01.854424) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-07-07 14:47:01.854860) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e31afd3c0f0de4e86ebe4d94000001b5-1467927894.647237-886956406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:47:02 INFO - MultiFileLogger online at 20160707 14:47:02 in /builds/slave/test 14:47:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 14:47:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:47:02 INFO - {'append_to_log': False, 14:47:02 INFO - 'base_work_dir': '/builds/slave/test', 14:47:02 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 14:47:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:47:02 INFO - 'branch': 'Fx-Team-Non-PGO', 14:47:02 INFO - 'buildbot_json_path': 'buildprops.json', 14:47:02 INFO - 'config_files': ('talos/linux_config.py',), 14:47:02 INFO - 'default_actions': ('clobber', 14:47:02 INFO - 'read-buildbot-config', 14:47:02 INFO - 'download-and-extract', 14:47:02 INFO - 'populate-webroot', 14:47:02 INFO - 'create-virtualenv', 14:47:02 INFO - 'install', 14:47:02 INFO - 'run-tests'), 14:47:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:47:02 INFO - 'download_minidump_stackwalk': True, 14:47:02 INFO - 'download_symbols': 'ondemand', 14:47:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:47:02 INFO - 'tooltool.py': '/tools/tooltool.py', 14:47:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:47:02 INFO - '/tools/misc-python/virtualenv.py')}, 14:47:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:47:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:47:02 INFO - 'installer_path': 'installer.exe', 14:47:02 INFO - 'log_level': 'info', 14:47:02 INFO - 'log_name': 'talos', 14:47:02 INFO - 'log_to_console': True, 14:47:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:47:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:47:02 INFO - 'opt_config_files': (), 14:47:02 INFO - 'pip_index': False, 14:47:02 INFO - 'sps_profile': False, 14:47:02 INFO - 'sps_profile_interval': 0, 14:47:02 INFO - 'suite': 'dromaeojs', 14:47:02 INFO - 'system_bits': '32', 14:47:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:47:02 INFO - 'title': 'talos-linux64-ix-006', 14:47:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:47:02 INFO - 'use_talos_json': True, 14:47:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:47:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:47:02 INFO - 'work_dir': 'build'} 14:47:02 INFO - ##### 14:47:02 INFO - ##### Running clobber step. 14:47:02 INFO - ##### 14:47:02 INFO - Running pre-action listener: _resource_record_pre_action 14:47:02 INFO - Running main action method: clobber 14:47:02 INFO - rmtree: /builds/slave/test/build 14:47:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:47:03 INFO - Running post-action listener: _resource_record_post_action 14:47:03 INFO - ##### 14:47:03 INFO - ##### Finished clobber step (success) 14:47:03 INFO - ##### 14:47:03 INFO - ##### 14:47:03 INFO - ##### Running read-buildbot-config step. 14:47:03 INFO - ##### 14:47:03 INFO - Running pre-action listener: _resource_record_pre_action 14:47:03 INFO - Running main action method: read_buildbot_config 14:47:03 INFO - Using buildbot properties: 14:47:03 INFO - { 14:47:03 INFO - "project": "", 14:47:03 INFO - "product": "firefox", 14:47:03 INFO - "script_repo_revision": "production", 14:47:03 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:47:03 INFO - "repository": "", 14:47:03 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 14:47:03 INFO - "buildid": "20160707141926", 14:47:03 INFO - "pgo_build": "False", 14:47:03 INFO - "basedir": "/builds/slave/test", 14:47:03 INFO - "buildnumber": 1945, 14:47:03 INFO - "slavename": "talos-linux64-ix-006", 14:47:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:47:03 INFO - "platform": "ubuntu64_hw", 14:47:03 INFO - "scheduler": "tests-fx-team-linux64-talos", 14:47:03 INFO - "branch": "fx-team", 14:47:03 INFO - "repo_path": "integration/fx-team", 14:47:03 INFO - "revision": "8e07e417a5bb24c48486e560ec5823f17dbe3403", 14:47:03 INFO - "stage_platform": "linux64", 14:47:03 INFO - "builduid": "2ec022409c754ff0a2e20e32d6ed5d5c", 14:47:03 INFO - "slavebuilddir": "test" 14:47:03 INFO - } 14:47:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/HNoQlJIDSyyBmBr4sU32aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 14:47:03 INFO - Running post-action listener: _resource_record_post_action 14:47:03 INFO - ##### 14:47:03 INFO - ##### Finished read-buildbot-config step (success) 14:47:03 INFO - ##### 14:47:03 INFO - ##### 14:47:03 INFO - ##### Running download-and-extract step. 14:47:03 INFO - ##### 14:47:03 INFO - Running pre-action listener: _resource_record_pre_action 14:47:03 INFO - Running main action method: download_and_extract 14:47:03 INFO - mkdir: /builds/slave/test/build/tests 14:47: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')]} 14:47:03 INFO - https://queue.taskcluster.net/v1/task/HNoQlJIDSyyBmBr4sU32aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:47:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNoQlJIDSyyBmBr4sU32aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:47:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNoQlJIDSyyBmBr4sU32aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:47:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNoQlJIDSyyBmBr4sU32aw/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 14:47:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNoQlJIDSyyBmBr4sU32aw/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 14:47:07 INFO - Downloaded 1361 bytes. 14:47:07 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:47:07 INFO - Using the following test package requirements: 14:47:07 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:47:07 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:47:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:47:07 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:47:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:47:07 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:47:07 INFO - u'jsshell-linux-x86_64.zip'], 14:47:07 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:47:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:47:07 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:47:07 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:47:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:47:07 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:47:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:47:07 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:47:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:47:07 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:47:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:47:07 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:47:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:47:07 INFO - https://queue.taskcluster.net/v1/task/HNoQlJIDSyyBmBr4sU32aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:47:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNoQlJIDSyyBmBr4sU32aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:47:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNoQlJIDSyyBmBr4sU32aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:47:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNoQlJIDSyyBmBr4sU32aw/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 14:47:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNoQlJIDSyyBmBr4sU32aw/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 14:47:08 INFO - Downloaded 22734622 bytes. 14:47:08 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'] 14:47:08 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 14:47:10 INFO - Return code: 0 14:47:10 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 14:47: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')]} 14:47:10 INFO - https://queue.taskcluster.net/v1/task/HNoQlJIDSyyBmBr4sU32aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:47:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNoQlJIDSyyBmBr4sU32aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:47:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNoQlJIDSyyBmBr4sU32aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:47:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNoQlJIDSyyBmBr4sU32aw/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 14:47:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNoQlJIDSyyBmBr4sU32aw/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 14:47:17 INFO - Downloaded 22734622 bytes. 14:47: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'] 14:47: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 14:47:19 INFO - Return code: 0 14:47: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')]} 14:47:19 INFO - https://queue.taskcluster.net/v1/task/HNoQlJIDSyyBmBr4sU32aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:47:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNoQlJIDSyyBmBr4sU32aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:47:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNoQlJIDSyyBmBr4sU32aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:47:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNoQlJIDSyyBmBr4sU32aw/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 14:47:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNoQlJIDSyyBmBr4sU32aw/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 14:47:20 INFO - Downloaded 14403333 bytes. 14:47: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'] 14:47: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 14:47:20 INFO - Return code: 0 14:47:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:47:20 INFO - https://queue.taskcluster.net/v1/task/HNoQlJIDSyyBmBr4sU32aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:47:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNoQlJIDSyyBmBr4sU32aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:47:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNoQlJIDSyyBmBr4sU32aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:47:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNoQlJIDSyyBmBr4sU32aw/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 14:47:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNoQlJIDSyyBmBr4sU32aw/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 14:47:22 INFO - Downloaded 56643312 bytes. 14:47:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HNoQlJIDSyyBmBr4sU32aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:47:22 INFO - mkdir: /builds/slave/test/properties 14:47:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:47:22 INFO - Writing to file /builds/slave/test/properties/build_url 14:47:22 INFO - Contents: 14:47:22 INFO - build_url:https://queue.taskcluster.net/v1/task/HNoQlJIDSyyBmBr4sU32aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:47:22 INFO - Running post-action listener: _resource_record_post_action 14:47:22 INFO - Running post-action listener: set_extra_try_arguments 14:47:22 INFO - ##### 14:47:22 INFO - ##### Finished download-and-extract step (success) 14:47:22 INFO - ##### 14:47:22 INFO - ##### 14:47:22 INFO - ##### Running populate-webroot step. 14:47:22 INFO - ##### 14:47:22 INFO - Running pre-action listener: _resource_record_pre_action 14:47:22 INFO - Running main action method: populate_webroot 14:47:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:47:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:47:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:47:22 INFO - '--tppagecycles', 14:47:22 INFO - '7'], 14:47:22 INFO - 'tests': ['tsvgm']}}, 14:47:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:47:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:47:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:47:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:47:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:47:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:47:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:47:22 INFO - 'talos_options': ['--disable-e10s'], 14:47:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:47:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:47:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:47:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:47:22 INFO - 'talos_options': ['--disable-e10s'], 14:47:22 INFO - 'tests': ['damp', 'tps']}, 14:47:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:47:22 INFO - 'tests': ['damp', 'tps']}, 14:47:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:47:22 INFO - 'tests': ['dromaeo_dom']}, 14:47:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:47:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:47:22 INFO - 'tests': ['basic_compositor_video']}, 14:47:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:47:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:47:22 INFO - 'tests': ['a11yr', 14:47:22 INFO - 'ts_paint', 14:47:22 INFO - 'tpaint', 14:47:22 INFO - 'sessionrestore', 14:47:22 INFO - 'sessionrestore_no_auto_restore', 14:47:22 INFO - 'tabpaint']}, 14:47:22 INFO - 'other-e10s': {'tests': ['a11yr', 14:47:22 INFO - 'ts_paint', 14:47:22 INFO - 'tpaint', 14:47:22 INFO - 'sessionrestore', 14:47:22 INFO - 'sessionrestore_no_auto_restore', 14:47:22 INFO - 'tabpaint']}, 14:47:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:47:22 INFO - 'ts_paint', 14:47:22 INFO - 'tpaint', 14:47:22 INFO - 'sessionrestore', 14:47:22 INFO - 'sessionrestore_no_auto_restore', 14:47:22 INFO - 'tabpaint']}, 14:47:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:47:22 INFO - 'ts_paint', 14:47:22 INFO - 'tpaint', 14:47:22 INFO - 'sessionrestore', 14:47:22 INFO - 'sessionrestore_no_auto_restore', 14:47:22 INFO - 'tabpaint']}, 14:47:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:47:22 INFO - 'tests': ['a11yr', 14:47:22 INFO - 'ts_paint', 14:47:22 INFO - 'tpaint', 14:47:22 INFO - 'sessionrestore', 14:47:22 INFO - 'sessionrestore_no_auto_restore', 14:47:22 INFO - 'tabpaint']}, 14:47:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:47:22 INFO - 'tests': ['a11yr', 14:47:22 INFO - 'ts_paint', 14:47:22 INFO - 'tpaint', 14:47:22 INFO - 'sessionrestore', 14:47:22 INFO - 'sessionrestore_no_auto_restore', 14:47:22 INFO - 'tabpaint']}, 14:47:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:47:22 INFO - 'tests': ['tsvgx', 14:47:22 INFO - 'tsvgr_opacity', 14:47:22 INFO - 'tart', 14:47:22 INFO - 'tscrollx', 14:47:22 INFO - 'cart']}, 14:47:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:47:22 INFO - 'tsvgr_opacity', 14:47:22 INFO - 'tart', 14:47:22 INFO - 'tscrollx', 14:47:22 INFO - 'cart']}, 14:47:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:47:22 INFO - 'talos_options': ['--disable-e10s'], 14:47:22 INFO - 'tests': ['tp5o']}, 14:47:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:47:22 INFO - 'tests': ['tp5o']}, 14:47:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:47:22 INFO - 'talos_options': ['--disable-e10s', 14:47:22 INFO - '--xperf_path', 14:47:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:47:22 INFO - 'tests': ['tp5n']}, 14:47:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:47:22 INFO - 'talos_options': ['--xperf_path', 14:47:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:47:22 INFO - 'tests': ['tp5n']}}, 14:47:22 INFO - 'talos.zip': {'path': '', 14:47:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:47:22 INFO - Running post-action listener: _resource_record_post_action 14:47:22 INFO - ##### 14:47:22 INFO - ##### Finished populate-webroot step (success) 14:47:22 INFO - ##### 14:47:22 INFO - ##### 14:47:22 INFO - ##### Running create-virtualenv step. 14:47:22 INFO - ##### 14:47:22 INFO - Running pre-action listener: _resource_record_pre_action 14:47:22 INFO - Running main action method: create_virtualenv 14:47:22 INFO - Creating virtualenv /builds/slave/test/build/venv 14:47:22 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 14:47:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:47:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:47:22 INFO - Using real prefix '/usr' 14:47:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:47:23 INFO - Installing distribute.............................................................................................................................................................................................done. 14:47:25 INFO - Installing pip.................done. 14:47:25 INFO - Return code: 0 14:47:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:47:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:47:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:47:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:25 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 0xe58030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1119180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11173b0>, '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 0x11182b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1118740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467927894.647237-886956406', '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 14:47:25 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 14:47:25 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 14:47:25 INFO - Using env: {'DISPLAY': ':0', 14:47:25 INFO - 'HOME': '/home/cltbld', 14:47:25 INFO - 'LANG': 'en_US.UTF-8', 14:47:25 INFO - 'LANGUAGE': 'en_US:en', 14:47:25 INFO - 'LOGNAME': 'cltbld', 14:47:25 INFO - 'MAIL': '/var/mail/cltbld', 14:47:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:25 INFO - 'MOZ_NO_REMOTE': '1', 14:47:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:47:25 INFO - 'NO_EM_RESTART': '1', 14:47:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:47:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:25 INFO - 'PWD': '/builds/slave/test', 14:47:25 INFO - 'SHELL': '/bin/bash', 14:47:25 INFO - 'SHLVL': '1', 14:47:25 INFO - 'TERM': 'linux', 14:47:25 INFO - 'TMOUT': '86400', 14:47:25 INFO - 'USER': 'cltbld', 14:47:25 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467927894.647237-886956406', 14:47:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:25 INFO - '_': '/tools/buildbot/bin/python'} 14:47:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:25 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 14:47:25 INFO - Cleaning up... 14:47:25 INFO - Return code: 0 14:47:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:47:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:47:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:47:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:25 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 0xe58030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1119180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11173b0>, '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 0x11182b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1118740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467927894.647237-886956406', '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 14:47:25 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 14:47:25 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 14:47:25 INFO - Using env: {'DISPLAY': ':0', 14:47:25 INFO - 'HOME': '/home/cltbld', 14:47:25 INFO - 'LANG': 'en_US.UTF-8', 14:47:25 INFO - 'LANGUAGE': 'en_US:en', 14:47:25 INFO - 'LOGNAME': 'cltbld', 14:47:25 INFO - 'MAIL': '/var/mail/cltbld', 14:47:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:25 INFO - 'MOZ_NO_REMOTE': '1', 14:47:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:47:25 INFO - 'NO_EM_RESTART': '1', 14:47:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:47:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:25 INFO - 'PWD': '/builds/slave/test', 14:47:25 INFO - 'SHELL': '/bin/bash', 14:47:25 INFO - 'SHLVL': '1', 14:47:25 INFO - 'TERM': 'linux', 14:47:25 INFO - 'TMOUT': '86400', 14:47:25 INFO - 'USER': 'cltbld', 14:47:25 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467927894.647237-886956406', 14:47:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:25 INFO - '_': '/tools/buildbot/bin/python'} 14:47:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:25 INFO - Downloading/unpacking psutil>=3.1.1 14:47:25 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 14:47:25 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 14:47:25 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 14:47:25 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 14:47:25 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 14:47:25 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 14:47:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:47:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:47:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:47:27 INFO - Installing collected packages: psutil 14:47:27 INFO - Running setup.py install for psutil 14:47:27 INFO - building 'psutil._psutil_linux' extension 14:47:27 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 14:47:28 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 14:47:28 INFO - building 'psutil._psutil_posix' extension 14:47:28 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 14:47:28 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 14:47:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:47:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:47:28 INFO - Successfully installed psutil 14:47:28 INFO - Cleaning up... 14:47:28 INFO - Return code: 0 14:47:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:47:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:47:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:47:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:28 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 0xe58030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1119180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11173b0>, '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 0x11182b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1118740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467927894.647237-886956406', '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 14:47:28 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 14:47:28 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 14:47:28 INFO - Using env: {'DISPLAY': ':0', 14:47:28 INFO - 'HOME': '/home/cltbld', 14:47:28 INFO - 'LANG': 'en_US.UTF-8', 14:47:28 INFO - 'LANGUAGE': 'en_US:en', 14:47:28 INFO - 'LOGNAME': 'cltbld', 14:47:28 INFO - 'MAIL': '/var/mail/cltbld', 14:47:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:28 INFO - 'MOZ_NO_REMOTE': '1', 14:47:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:47:28 INFO - 'NO_EM_RESTART': '1', 14:47:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:47:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:28 INFO - 'PWD': '/builds/slave/test', 14:47:28 INFO - 'SHELL': '/bin/bash', 14:47:28 INFO - 'SHLVL': '1', 14:47:28 INFO - 'TERM': 'linux', 14:47:28 INFO - 'TMOUT': '86400', 14:47:28 INFO - 'USER': 'cltbld', 14:47:28 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467927894.647237-886956406', 14:47:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:28 INFO - '_': '/tools/buildbot/bin/python'} 14:47:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:47:28 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 14:47:28 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 14:47:28 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 14:47:28 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 14:47:28 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 14:47:28 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 14:47:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:47:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:47:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:47:30 INFO - Installing collected packages: mozsystemmonitor 14:47:30 INFO - Running setup.py install for mozsystemmonitor 14:47:30 INFO - Successfully installed mozsystemmonitor 14:47:30 INFO - Cleaning up... 14:47:30 INFO - Return code: 0 14:47:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:47:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:47:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xe58030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1119180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11173b0>, '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 0x11182b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1118740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467927894.647237-886956406', '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 14:47:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:47:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:47:30 INFO - Using env: {'DISPLAY': ':0', 14:47:30 INFO - 'HOME': '/home/cltbld', 14:47:30 INFO - 'LANG': 'en_US.UTF-8', 14:47:30 INFO - 'LANGUAGE': 'en_US:en', 14:47:30 INFO - 'LOGNAME': 'cltbld', 14:47:30 INFO - 'MAIL': '/var/mail/cltbld', 14:47:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:30 INFO - 'MOZ_NO_REMOTE': '1', 14:47:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:47:30 INFO - 'NO_EM_RESTART': '1', 14:47:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:47:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:30 INFO - 'PWD': '/builds/slave/test', 14:47:30 INFO - 'SHELL': '/bin/bash', 14:47:30 INFO - 'SHLVL': '1', 14:47:30 INFO - 'TERM': 'linux', 14:47:30 INFO - 'TMOUT': '86400', 14:47:30 INFO - 'USER': 'cltbld', 14:47:30 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467927894.647237-886956406', 14:47:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:30 INFO - '_': '/tools/buildbot/bin/python'} 14:47:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:30 INFO - Downloading/unpacking jsonschema==2.5.1 14:47:30 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 14:47:30 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 14:47:30 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 14:47:30 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 14:47:30 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 14:47:30 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 14:47:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:47:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:47:32 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 14:47:32 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 14:47:32 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 14:47:32 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 14:47:32 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 14:47:32 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 14:47:33 INFO - Downloading functools32-3.2.3-2.tar.gz 14:47:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:47:33 INFO - warning: no files found matching '*.txt' 14:47:33 INFO - no previously-included directories found matching 'build' 14:47:33 INFO - no previously-included directories found matching 'dist' 14:47:33 INFO - no previously-included directories found matching '.git*' 14:47:33 INFO - Installing collected packages: jsonschema, functools32 14:47:33 INFO - Running setup.py install for functools32 14:47:33 INFO - warning: no files found matching '*.txt' 14:47:33 INFO - no previously-included directories found matching 'build' 14:47:33 INFO - no previously-included directories found matching 'dist' 14:47:33 INFO - no previously-included directories found matching '.git*' 14:47:33 INFO - Successfully installed jsonschema functools32 14:47:33 INFO - Cleaning up... 14:47:33 INFO - Return code: 0 14:47:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:47: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')]} 14:47:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47: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')]} 14:47:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47: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', '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 0xe58030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1119180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11173b0>, '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 0x11182b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1118740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467927894.647237-886956406', '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 14:47: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:47: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 blobuploader==1.2.4 14:47:33 INFO - Using env: {'DISPLAY': ':0', 14:47:33 INFO - 'HOME': '/home/cltbld', 14:47:33 INFO - 'LANG': 'en_US.UTF-8', 14:47:33 INFO - 'LANGUAGE': 'en_US:en', 14:47:33 INFO - 'LOGNAME': 'cltbld', 14:47:33 INFO - 'MAIL': '/var/mail/cltbld', 14:47:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:33 INFO - 'MOZ_NO_REMOTE': '1', 14:47:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:47:33 INFO - 'NO_EM_RESTART': '1', 14:47:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:47:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:33 INFO - 'PWD': '/builds/slave/test', 14:47:33 INFO - 'SHELL': '/bin/bash', 14:47:33 INFO - 'SHLVL': '1', 14:47:33 INFO - 'TERM': 'linux', 14:47:33 INFO - 'TMOUT': '86400', 14:47:33 INFO - 'USER': 'cltbld', 14:47:33 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467927894.647237-886956406', 14:47:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:33 INFO - '_': '/tools/buildbot/bin/python'} 14:47:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:33 INFO - Downloading/unpacking blobuploader==1.2.4 14:47: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 14:47: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 14:47: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 14:47: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 14:47: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 14:47: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 14:47:35 INFO - Downloading blobuploader-1.2.4.tar.gz 14:47:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:47:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:47: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 14:47: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 14:47: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 14:47: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 14:47: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 14:47: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 14:47:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:47:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:47: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 14:47: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 14:47: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 14:47: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 14:47: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 14:47: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 14:47:36 INFO - Downloading docopt-0.6.1.tar.gz 14:47:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:47:36 INFO - Installing collected packages: blobuploader, requests, docopt 14:47:36 INFO - Running setup.py install for blobuploader 14:47:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:47:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:47:36 INFO - Running setup.py install for requests 14:47:36 INFO - Running setup.py install for docopt 14:47:36 INFO - Successfully installed blobuploader requests docopt 14:47:36 INFO - Cleaning up... 14:47:36 INFO - Return code: 0 14:47:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:47: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')]} 14:47:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47: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')]} 14:47:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:36 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 0xe58030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1119180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11173b0>, '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 0x11182b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1118740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467927894.647237-886956406', '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 14:47:36 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 14:47:36 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 14:47:36 INFO - Using env: {'DISPLAY': ':0', 14:47:36 INFO - 'HOME': '/home/cltbld', 14:47:36 INFO - 'LANG': 'en_US.UTF-8', 14:47:36 INFO - 'LANGUAGE': 'en_US:en', 14:47:36 INFO - 'LOGNAME': 'cltbld', 14:47:36 INFO - 'MAIL': '/var/mail/cltbld', 14:47:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:36 INFO - 'MOZ_NO_REMOTE': '1', 14:47:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:47:36 INFO - 'NO_EM_RESTART': '1', 14:47:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:47:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:36 INFO - 'PWD': '/builds/slave/test', 14:47:36 INFO - 'SHELL': '/bin/bash', 14:47:36 INFO - 'SHLVL': '1', 14:47:36 INFO - 'TERM': 'linux', 14:47:36 INFO - 'TMOUT': '86400', 14:47:36 INFO - 'USER': 'cltbld', 14:47:36 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467927894.647237-886956406', 14:47:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:36 INFO - '_': '/tools/buildbot/bin/python'} 14:47:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:47:37 INFO - Running setup.py (path:/tmp/pip-0pS_FC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:47:37 INFO - Running setup.py (path:/tmp/pip-P_1FMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:47:37 INFO - Running setup.py (path:/tmp/pip-buGsMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:47:37 INFO - Running setup.py (path:/tmp/pip-o5jp9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:47:37 INFO - Running setup.py (path:/tmp/pip-WajsFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:47:37 INFO - Running setup.py (path:/tmp/pip-AOzK16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:47:37 INFO - Running setup.py (path:/tmp/pip-0WrI2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:47:37 INFO - Running setup.py (path:/tmp/pip-nNSi2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:47:37 INFO - Running setup.py (path:/tmp/pip-T5zMo1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:47:37 INFO - Running setup.py (path:/tmp/pip-IXwnSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:47:37 INFO - Running setup.py (path:/tmp/pip-RfbKOt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:47:37 INFO - Running setup.py (path:/tmp/pip-LDaMDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:47:37 INFO - Running setup.py (path:/tmp/pip-QcHI0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:47:37 INFO - Running setup.py (path:/tmp/pip-kU_bUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:47:38 INFO - Running setup.py (path:/tmp/pip-YkHf97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:47:38 INFO - Running setup.py (path:/tmp/pip-jL23qp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:47:38 INFO - Running setup.py (path:/tmp/pip-pR3_Qi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:47:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:47:38 INFO - Running setup.py install for manifestparser 14:47:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:47:38 INFO - Running setup.py install for mozcrash 14:47:38 INFO - Running setup.py install for mozdebug 14:47:38 INFO - Running setup.py install for mozdevice 14:47:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:47:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:47:38 INFO - Running setup.py install for mozfile 14:47:38 INFO - Running setup.py install for mozhttpd 14:47:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:47:38 INFO - Running setup.py install for mozinfo 14:47:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:47:38 INFO - Running setup.py install for mozInstall 14:47:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:47:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:47:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:47:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:47:39 INFO - Running setup.py install for mozleak 14:47:39 INFO - Running setup.py install for mozlog 14:47:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:47:39 INFO - Running setup.py install for moznetwork 14:47:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:47:39 INFO - Running setup.py install for mozprocess 14:47:39 INFO - Running setup.py install for mozprofile 14:47:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:47:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:47:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:47:39 INFO - Running setup.py install for mozrunner 14:47:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:47:39 INFO - Running setup.py install for mozscreenshot 14:47:39 INFO - Running setup.py install for moztest 14:47:39 INFO - Running setup.py install for mozversion 14:47:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:47:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:47:40 INFO - Cleaning up... 14:47:40 INFO - Return code: 0 14:47:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:47:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:47:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:47:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:40 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 0xe58030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1119180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11173b0>, '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 0x11182b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1118740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467927894.647237-886956406', '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 14:47:40 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 14:47:40 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 14:47:40 INFO - Using env: {'DISPLAY': ':0', 14:47:40 INFO - 'HOME': '/home/cltbld', 14:47:40 INFO - 'LANG': 'en_US.UTF-8', 14:47:40 INFO - 'LANGUAGE': 'en_US:en', 14:47:40 INFO - 'LOGNAME': 'cltbld', 14:47:40 INFO - 'MAIL': '/var/mail/cltbld', 14:47:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:40 INFO - 'MOZ_NO_REMOTE': '1', 14:47:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:47:40 INFO - 'NO_EM_RESTART': '1', 14:47:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:47:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:40 INFO - 'PWD': '/builds/slave/test', 14:47:40 INFO - 'SHELL': '/bin/bash', 14:47:40 INFO - 'SHLVL': '1', 14:47:40 INFO - 'TERM': 'linux', 14:47:40 INFO - 'TMOUT': '86400', 14:47:40 INFO - 'USER': 'cltbld', 14:47:40 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467927894.647237-886956406', 14:47:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:40 INFO - '_': '/tools/buildbot/bin/python'} 14:47:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:47:40 INFO - Running setup.py (path:/tmp/pip-c_IiJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:47:40 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)) 14:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:47:40 INFO - Running setup.py (path:/tmp/pip-nNvlyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:47:40 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)) 14:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:47:40 INFO - Running setup.py (path:/tmp/pip-CYEmPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:47:40 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)) 14:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:47:40 INFO - Running setup.py (path:/tmp/pip-nBa7Zh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:47:40 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)) 14:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:47:40 INFO - Running setup.py (path:/tmp/pip-hewVQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:47:40 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)) 14:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:47:40 INFO - Running setup.py (path:/tmp/pip-azdD15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:47:40 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)) 14:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:47:40 INFO - Running setup.py (path:/tmp/pip-r5stJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:47:40 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)) 14:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:47:40 INFO - Running setup.py (path:/tmp/pip-eqPsUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:47:40 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)) 14:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:47:40 INFO - Running setup.py (path:/tmp/pip-wcbK_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:47:40 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)) 14:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:47:40 INFO - Running setup.py (path:/tmp/pip-TX8E10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:47:40 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)) 14:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:47:40 INFO - Running setup.py (path:/tmp/pip-QGPoj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:47:41 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)) 14:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:47:41 INFO - Running setup.py (path:/tmp/pip-SakNKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:47:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:47:41 INFO - Running setup.py (path:/tmp/pip-J7MLsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:47:41 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)) 14:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:47:41 INFO - Running setup.py (path:/tmp/pip-I1pMfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:47:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:47:41 INFO - Running setup.py (path:/tmp/pip-qy5EWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:47:41 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)) 14:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:47:41 INFO - Running setup.py (path:/tmp/pip-OCoBbK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:47:41 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)) 14:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:47:41 INFO - Running setup.py (path:/tmp/pip-bjhkAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:47:41 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)) 14:47:41 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)) 14:47:41 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)) 14:47:41 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)) 14:47:41 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)) 14:47:41 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)) 14:47:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:47:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:47:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:43 INFO - Downloading blessings-1.6.tar.gz 14:47:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:47:43 INFO - Installing collected packages: blessings 14:47:43 INFO - Running setup.py install for blessings 14:47:43 INFO - Successfully installed blessings 14:47:43 INFO - Cleaning up... 14:47:43 INFO - Return code: 0 14:47:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:47:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:47:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:47:43 INFO - Reading from file tmpfile_stdout 14:47:43 INFO - Current package versions: 14:47:43 INFO - argparse == 1.2.1 14:47:43 INFO - blessings == 1.6 14:47:43 INFO - blobuploader == 1.2.4 14:47:43 INFO - docopt == 0.6.1 14:47:43 INFO - functools32 == 3.2.3-2 14:47:43 INFO - jsonschema == 2.5.1 14:47:43 INFO - manifestparser == 1.1 14:47:43 INFO - mozInstall == 1.12 14:47:43 INFO - mozcrash == 0.17 14:47:43 INFO - mozdebug == 0.1 14:47:43 INFO - mozdevice == 0.48 14:47:43 INFO - mozfile == 1.2 14:47:43 INFO - mozhttpd == 0.7 14:47:43 INFO - mozinfo == 0.9 14:47:43 INFO - mozleak == 0.1 14:47:43 INFO - mozlog == 3.2 14:47:43 INFO - moznetwork == 0.27 14:47:43 INFO - mozprocess == 0.23 14:47:43 INFO - mozprofile == 0.28 14:47:43 INFO - mozrunner == 6.12 14:47:43 INFO - mozscreenshot == 0.1 14:47:43 INFO - mozsystemmonitor == 0.3 14:47:43 INFO - moztest == 0.7 14:47:43 INFO - mozversion == 1.4 14:47:43 INFO - psutil == 3.1.1 14:47:43 INFO - requests == 1.2.3 14:47:43 INFO - wsgiref == 0.1.2 14:47:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:47: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')]} 14:47:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47: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')]} 14:47:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:43 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 0xe58030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1119180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11173b0>, '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 0x11182b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1118740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467927894.647237-886956406', '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 14:47:43 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 14:47:43 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 14:47:43 INFO - Using env: {'DISPLAY': ':0', 14:47:43 INFO - 'HOME': '/home/cltbld', 14:47:43 INFO - 'LANG': 'en_US.UTF-8', 14:47:43 INFO - 'LANGUAGE': 'en_US:en', 14:47:43 INFO - 'LOGNAME': 'cltbld', 14:47:43 INFO - 'MAIL': '/var/mail/cltbld', 14:47:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:43 INFO - 'MOZ_NO_REMOTE': '1', 14:47:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:47:43 INFO - 'NO_EM_RESTART': '1', 14:47:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:47:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:43 INFO - 'PWD': '/builds/slave/test', 14:47:43 INFO - 'SHELL': '/bin/bash', 14:47:43 INFO - 'SHLVL': '1', 14:47:43 INFO - 'TERM': 'linux', 14:47:43 INFO - 'TMOUT': '86400', 14:47:43 INFO - 'USER': 'cltbld', 14:47:43 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467927894.647237-886956406', 14:47:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:43 INFO - '_': '/tools/buildbot/bin/python'} 14:47:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:44 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)) 14:47:44 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)) 14:47:44 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)) 14:47:44 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)) 14:47:44 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)) 14:47:44 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)) 14:47:44 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)) 14:47:44 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)) 14:47:44 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)) 14:47:44 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)) 14:47:44 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)) 14:47:44 INFO - Cleaning up... 14:47:44 INFO - Return code: 0 14:47:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:47:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:47:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:47:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe58030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1119180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11173b0>, '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 0x11182b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1118740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467927894.647237-886956406', '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 14:47:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:47:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:47:44 INFO - Using env: {'DISPLAY': ':0', 14:47:44 INFO - 'HOME': '/home/cltbld', 14:47:44 INFO - 'LANG': 'en_US.UTF-8', 14:47:44 INFO - 'LANGUAGE': 'en_US:en', 14:47:44 INFO - 'LOGNAME': 'cltbld', 14:47:44 INFO - 'MAIL': '/var/mail/cltbld', 14:47:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:44 INFO - 'MOZ_NO_REMOTE': '1', 14:47:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:47:44 INFO - 'NO_EM_RESTART': '1', 14:47:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:47:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:44 INFO - 'PWD': '/builds/slave/test', 14:47:44 INFO - 'SHELL': '/bin/bash', 14:47:44 INFO - 'SHLVL': '1', 14:47:44 INFO - 'TERM': 'linux', 14:47:44 INFO - 'TMOUT': '86400', 14:47:44 INFO - 'USER': 'cltbld', 14:47:44 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467927894.647237-886956406', 14:47:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:44 INFO - '_': '/tools/buildbot/bin/python'} 14:47:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:47:44 INFO - Cleaning up... 14:47:44 INFO - Return code: 0 14:47:44 INFO - Running post-action listener: _resource_record_post_action 14:47:44 INFO - Running post-action listener: _start_resource_monitoring 14:47:44 INFO - Starting resource monitoring. 14:47:44 INFO - ##### 14:47:44 INFO - ##### Finished create-virtualenv step (success) 14:47:44 INFO - ##### 14:47:44 INFO - ##### 14:47:44 INFO - ##### Running install step. 14:47:44 INFO - ##### 14:47:44 INFO - Running pre-action listener: _resource_record_pre_action 14:47:44 INFO - Running main action method: install 14:47:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:47:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:47:44 INFO - Reading from file tmpfile_stdout 14:47:44 INFO - Detecting whether we're running mozinstall >=1.0... 14:47:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:47:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:47:44 INFO - Reading from file tmpfile_stdout 14:47:44 INFO - Output received: 14:47:44 INFO - Usage: mozinstall [options] installer 14:47:44 INFO - Options: 14:47:44 INFO - -h, --help show this help message and exit 14:47:44 INFO - -d DEST, --destination=DEST 14:47:44 INFO - Directory to install application into. [default: 14:47:44 INFO - "/builds/slave/test"] 14:47:44 INFO - --app=APP Application being installed. [default: firefox] 14:47:44 INFO - mkdir: /builds/slave/test/build/application 14:47:44 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'] 14:47:44 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 14:48:00 INFO - Reading from file tmpfile_stdout 14:48:00 INFO - Output received: 14:48:00 INFO - /builds/slave/test/build/application/firefox/firefox 14:48:00 INFO - Running post-action listener: _resource_record_post_action 14:48:00 INFO - ##### 14:48:00 INFO - ##### Finished install step (success) 14:48:00 INFO - ##### 14:48:00 INFO - ##### 14:48:00 INFO - ##### Running run-tests step. 14:48:00 INFO - ##### 14:48:00 INFO - Running pre-action listener: _resource_record_pre_action 14:48:00 INFO - Running main action method: run_tests 14:48:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:48:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:48:00 INFO - Python 2.7.3 14:48:00 INFO - Return code: 0 14:48:00 INFO - grabbing minidump binary from tooltool 14:48:00 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')]} 14:48:00 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 0x11173b0>, '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 0x11182b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1118740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:48:00 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 14:48:00 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 14:48:00 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 14:48:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:48:00 INFO - Return code: 0 14:48:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:48:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:48:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:48:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:48:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:48:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HNoQlJIDSyyBmBr4sU32aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:48:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HNoQlJIDSyyBmBr4sU32aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:48:00 INFO - Using env: {'DISPLAY': ':0', 14:48:00 INFO - 'HOME': '/home/cltbld', 14:48:00 INFO - 'LANG': 'en_US.UTF-8', 14:48:00 INFO - 'LANGUAGE': 'en_US:en', 14:48:00 INFO - 'LOGNAME': 'cltbld', 14:48:00 INFO - 'MAIL': '/var/mail/cltbld', 14:48:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:48:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:48:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:00 INFO - 'MOZ_NO_REMOTE': '1', 14:48:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:48:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:00 INFO - 'NO_EM_RESTART': '1', 14:48:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:00 INFO - 'PWD': '/builds/slave/test', 14:48:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:48:00 INFO - 'SHELL': '/bin/bash', 14:48:00 INFO - 'SHLVL': '1', 14:48:00 INFO - 'TERM': 'linux', 14:48:00 INFO - 'TMOUT': '86400', 14:48:00 INFO - 'USER': 'cltbld', 14:48:00 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467927894.647237-886956406', 14:48:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:00 INFO - '_': '/tools/buildbot/bin/python'} 14:48:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HNoQlJIDSyyBmBr4sU32aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:48:01 INFO - mozversion application_buildid: 20160707141926 14:48:01 INFO - mozversion application_changeset: 8e07e417a5bb24c48486e560ec5823f17dbe3403 14:48:01 INFO - mozversion application_display_name: Nightly 14:48:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:48:01 INFO - mozversion application_name: Firefox 14:48:01 INFO - mozversion application_remotingname: firefox 14:48:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:48:01 INFO - mozversion application_vendor: Mozilla 14:48:01 INFO - mozversion application_version: 50.0a1 14:48:01 INFO - mozversion platform_buildid: 20160707141926 14:48:01 INFO - mozversion platform_changeset: 8e07e417a5bb24c48486e560ec5823f17dbe3403 14:48:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:48:01 INFO - mozversion platform_version: 50.0a1 14:48:01 INFO - using testdate: 1467928081 14:48:01 INFO - actual date: 1467928081 14:48:01 INFO - starting webserver on 'localhost:51202' 14:48:01 INFO - SUITE-START | Running 2 tests 14:48:01 INFO - TEST-START | dromaeo_css 14:48:01 INFO - operating with platform_type : linux_ 14:48:01 INFO - Initialising browser for dromaeo_css test... 14:48:01 INFO - TEST-INFO | started process 26673 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSoxypi/profile http://localhost:51202/getInfo.html) 14:48:05 INFO - PROCESS | 26673 | __metrics Screen width/height:1600/1200 14:48:05 INFO - PROCESS | 26673 | colorDepth:24 14:48:05 INFO - PROCESS | 26673 | Browser inner width/height: 1024/697 14:48:05 INFO - PROCESS | 26673 | __metrics 14:48:06 INFO - PROCESS | 26673 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:48:07 INFO - TEST-INFO | 26673: exit 0 14:48:07 INFO - Browser initialized. 14:48:07 INFO - Running cycle 1/1 for dromaeo_css test... 14:48:07 INFO - TEST-INFO | started process 26754 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSoxypi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:48:19 INFO - PROCESS | 26754 | RSS: Main: 157798400 14:48:19 INFO - PROCESS | 26754 | 14:49:10 INFO - PROCESS | 26754 | 1467928150551 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] 14:51:23 INFO - PROCESS | 26754 | Cycle 1(1): loaded http://localhost:51202/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51202/tests/dromaeo/cssquery-ext.html) 14:51:24 INFO - PROCESS | 26754 | RSS: Main: 234373120 14:51:24 INFO - PROCESS | 26754 | 14:54:27 INFO - PROCESS | 26754 | Cycle 1(1): loaded http://localhost:51202/tests/dromaeo/cssquery-ext.html (next: http://localhost:51202/tests/dromaeo/cssquery-jquery.html) 14:54:27 INFO - PROCESS | 26754 | RSS: Main: 247980032 14:54:27 INFO - PROCESS | 26754 | 14:57:30 INFO - PROCESS | 26754 | Cycle 1(1): loaded http://localhost:51202/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51202/tests/dromaeo/cssquery-mootools.html) 14:57:30 INFO - PROCESS | 26754 | RSS: Main: 246370304 14:57:30 INFO - PROCESS | 26754 | 15:00:32 INFO - PROCESS | 26754 | Cycle 1(1): loaded http://localhost:51202/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51202/tests/dromaeo/cssquery-prototype.html) 15:00:33 INFO - PROCESS | 26754 | RSS: Main: 244752384 15:00:33 INFO - PROCESS | 26754 | 15:03:36 INFO - PROCESS | 26754 | Cycle 1(1): loaded http://localhost:51202/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51202/tests/dromaeo/cssquery-yui.html) 15:03:37 INFO - PROCESS | 26754 | RSS: Main: 223174656 15:03:37 INFO - PROCESS | 26754 | 15:06:39 INFO - PROCESS | 26754 | Cycle 1(1): loaded http://localhost:51202/tests/dromaeo/cssquery-yui.html (next: http://localhost:51202/tests/dromaeo/cssquery-dojo.html) 15:06:39 INFO - PROCESS | 26754 | RSS: Main: 281042944 15:06:39 INFO - PROCESS | 26754 | 15:06:39 INFO - PROCESS | 26754 | __start_tp_report 15:06:39 INFO - PROCESS | 26754 | _x_x_mozilla_page_load 15:06:39 INFO - PROCESS | 26754 | _x_x_mozilla_page_load_details 15:06:39 INFO - PROCESS | 26754 | |i|pagename|runs| 15:06:39 INFO - PROCESS | 26754 | |0;dojo.html;2581.457893842293;2587.9482410351793;2608.035027039995;2618.554845676235;2624.632551442797;4681.9063618727605;4695.060987802436;4696.765161741912;4702.764861756916;4754.857354279368;4707.411573553306;4709.0581883623245;4737.455192652846;4802.687825291354;4812.518748125186;4284.4216030835905;4284.635805956497;4360.106178233455;4361.847335343264;4382.978085109586;4421.0494743630115;4467.88830279244;4487.932681009787;4490.820367185309;4507.504174540798;4310.48274207094;4366.541513141106;4372.060007098489;4390;4418.9337159942625;4403.735775853459;4419.933700994456;4420.7126536775;4422.027154026109;4422.270325396305;4384.517703052662;4394.934075988863;4395.1868904252815;4395.340698895159;4406.206882761102;4653.790579423934;4725.716457012556;4771.594414474774;4778.235482322812;4785.066911952171;5033.546980771748;5040.823571175028;5043.672161309503;5049.596032317406;5093.821716239914;5092.668976516515;5123.487651234884;5141.997310524449;5160.690358578498;5163.741812909339;4667.603253723403;4715.434147902273;4757.976210118927;4773.66584339093;4822.156122678517;5256.2904007959205;5305.4164041955355;5315.28243687105;5315.6279060465395;5323.6273460857365;4850.345203397566;5069.467705890902;5084.618653600995;5088.872778180576;5091.821786237538;4967.130752118364;4981.501849815062;5001.799928002839;5061.544460998528;5088.77100530477;4961.727105009187;4969.82605608802;4970.701757894538;4979.825706100269;5022.59819214462;4870.488598697157;4912.459629440758;4917.164082106051;4921;4932.90134197314;4312.762798046075;4358.6730995175485;4370.169667763115;4375.7155784873885;4419.690621656453;3737.2338670572467;3773.603771603942;3784.3377408953324;3800.220954704279;3815.236952609489;4206.390073439334;4296.355546667963;4309.806058727365;4343.109662519176;4357.063231405263;5038.974805125951;5082.567981721595;5086.338775959101;5120.795168193231;5123.257127716534;4255.234057869551;4274.679399045084;4293.613574778223;4340.956590434118;4342.9782851086175;4469.217886869785;4531.977340113278;4596.5863072323655;4599.195140850405;4601.240795268744;4744.501827308221;4748.643851711205;4775.450823155243;4821.54195351441;4828.517148285144;5128.974355128201;5132.10188217068;5136.7945282189785;5141.691498510101;5186.429492755869;4581.977090114661;4657.953420465888;4764.49972752856;4775.044991001744;4823.493533179106;4879.146149423766;4980.252962055721;5000.399952005637;5001.249812528004;5056.519630635084;5030.270610761492;5039.899202015866;5061;5062.848114556569;5086.109930762176;4838.225883858566;4878.56092951636;4894.828680996148;4908.533689299511;4919.508049195052;4960.751962401938;4972.975135124301;4982.551570358685;4982.676126051795;5018.598512118949;4912.435069966857;4919.729414882216;4957.553820156203;4970.428400733817;4971;4895.069936712013;4914.778834952364;4961.42943561495;4973.378327709036;5000.6249531284575;4879.243717223836;4880.389951256093;4903.16646170159;4904.460509343898;4939.357883475125 15:06:39 INFO - PROCESS | 26754 | |1;ext.html;570.5920267009088;578.2771535580524;581.3982528083432;585.8271809816104;595.603923390945;27032.189034328952;27597.172084837435;29733.256668583243;29780.851095744518;40390.59609403912;40971.795141024326;45704.771476142574;46579.534204658026;46656.533434665645;46683.299750503684;7688.384929205678;7831.451798374116;7831.804204894866;7834.451588388815;7835.138134805167;7583.279588439117;7755.26324999127;7844.882326765103;9936.105750482455;10178.89821101787;10069.244806639495;10113.443760593165;10125.139363154103;10135.89864101357;10149.746256343613;10144.847827282596;10208.285420020602;10212.489375531193;10221.642242521513;10223.693289201261;10041.246906482043;10083.546240419199;10089.646862359856;10102.39385636864;10114.54484548197;39719.8014009931;40042.59957400447;40146.59853401458;40175.59824401748;40185.79907100475;2927.6194094767757;3064.4024415239037;3271.345730853815;3297.9340413191603;3692.6122757110384;30223.848880755457;30564.38871222563;31018.0694579163;31187.84406077955;31234.53148202779;3607.801570913599;3631.455281707739;3643.708503319728;3646.81765911706;3752.4558938953974;257978;260737;260967;261415;261574.69212654006;52922;53254;53273.20090198573;53362.466375336524;53370.19944700832;57986.4201357981;58036.03567571834;58049.70975145182;58076.12885806716;58208.41791582115;13346.265955372548;13849;13892.513762018281;13903.930480347533;13965.092269002482;9132.771680708036;10224.64213752515;10270.589176433008;10294.845577316346;10295.845562316572;16491.91754041222;16870.240839162267;16950.576235593962;17584.56038599045;17606.647867042586;6254.593451425642;6255.218097737783;6288.465480434123;6566.080748695186;6579.868402631921;840.8864803251482;891.714651311574;923.1875949164692;945.8392073347547;953.6471505542855;28363.57454638182;28794;28865.711342886723;29353;29432.852835735684;956.7082039977735;1001.5242759689235;1004.4023805835516;1008.1229330482381;1029.8197815382277;14601.12393256408;15231.349342737685;15309.923450382677;15400.768988465183;15490;355869;358208;362562;362916;362957;49138.75430622824;49332.75333623381;49370.75314623404;49389.25916111261;49412;1042.374575254841;1163.4182908545897;1200.0939290835363;1208.4803534480081;1211.4003568233782;28680.856595716887;29743.25641858971;29858;29882;30066.84966575153;42566.78716606397;42718;43226.567734323515;43251.567484324754;43268.35097473478;234090;234584;234886;234950;235265;31115.68884311128;32299;36115;37179;37215.441768372955;41225.587744122175;41970.37044444397;42030.36954445625;42587.57412425836;42641.57358426376;36769;36953;37199.81400092982;37551.43672844964;37885.62114378821;35794.82102589471;36265.818670906476;37065.258694826494;37178.25643487169;37514.249715006095;35637.287254254254;35980.46029309615;36592.26815463729;36687.26625467422;36789.63210367862;30222.54666179965;34106.82946585251;34279.143021424665;34506.48240276448;34521;25746.356341090872;25840.22479325623;25869.22392328233;26203.868980654974;26257.474850503266 15:06:39 INFO - PROCESS | 26754 | |2;jquery.html;345.9121064252926;367.58646522662;373.67863637271944;373.8037530296594;390.56452055957595;12933.741325173503;16431.178441077944;16806.243719032642;16980.660386792257;17884.731729024075;16859.40992065275;17100.230489627964;17256.82743172568;17457.476275711717;17664.558386040357;5049.899002019948;5270.9736451317685;5553.527950124224;5560.304961879765;5649.548036157097;3376.7129793967542;5114.820981265657;5364.409914909357;5373.086575282211;5614.9893019256515;5426.104692725715;5431.266778984826;5435.782568697247;5451.100568406208;5455.236266922634;5284.445133260991;5326.866828329304;5407.864803379907;5411.918821217685;5434.809781657623;3280.311134661724;4982.750862456863;5262.23697563855;5278.392984806758;5278.841634750964;11581.305121692641;11704.356260405675;11833.704157396049;11867.762644747057;20300.5939881203;1814.2198854492563;1874.7656542932134;1896.0709252466193;1923.134589434746;1950.2004178286834;9197.40216885907;9330.766730831716;9392.718218453458;9459.66891158813;10771.407572583505;1759.8416142547105;1768.929242830298;1771.052486919492;1775.5561109722569;1795.093477793706;69508.6524567379;73803;74257;74495.62752186258;74603.62698186528;8901.510416927002;9067.093290671011;10013.148882344936;10148.492575371201;10571.788564228826;11302.321860688386;12035.518579256732;12052.397380130958;12258.325792081521;12288.508459661693;6851.246362900077;6957.65211739411;7016.298370162943;7113.857722845514;7134.143902731706;6756.662166891636;6851.143607049119;6893.862122757517;6928.930710692929;6980.825479363057;3862.787546684959;3871.090293780959;3903.277893589695;3943.4873466449176;4020;1690.2393922734818;1755.5260079778388;1765.5233087066676;1770.4246120011048;1770.64587082584;879.5514287713312;903.5617725403174;922.5940586142076;950.7432993091965;971.5385192033868;16501.669966600602;17218.655626887394;17219.741703874453;17306.826931730775;17751.46745597634;857.8970523537215;873.5850471026212;884.9292056635454;911.4121391702315;912.1972664055588;9121.863172052424;9694.272929530314;9696.418214907128;9701.126898579021;9807.117359437685;354741;357606;359563;359865;361052;76941;79739.60130199311;79994.20005799868;80601.59699201466;81813.59093204496;858.1718641510972;868.3313848336871;870.1211776106052;871.5729292646685;871.8822958900467;14720.705585888436;15196.544103676908;15280.15959122259;15345.386184552493;15784.60538486547;36680.449793253654;36781;37657.81171094127;38227.42658860064;38488.2302353957;51411.2288315683;53384;53940.460595393546;54007.459925400246;54054.729726351114;4631.907361852812;4732.929006064981;7389.7413590524075;7448.9627551861895;7527.397808175442;10606.522706478072;11400.372979486208;11435.428228588704;11485.138614603771;11638.243514171552;9899.950500247453;10253.179745620482;10375.533101010624;10441.895581044093;10443.68668939933;10064.647737329158;10086.949565252127;10130.696079117639;10151.94924025375;10300.278980471296;10177.949110254402;10448.164146868081;10543.630972915911;10543.736406589896;10642.73393165177;7290.5625662460425;7362.079740032496;7427.888581671171;7476.065491813523;7565.016547848964;8029.397795165269;10153.847692284475;10257.076863082359;10260.333078350182;10309.123724483203 15:06:39 INFO - PROCESS | 26754 | |3;mootools.html;1250.312328219479;1373.402569882101;1412;1505.7741338799178;1732.4715961631698;6720.596764194146;7570.09158900932;7804.765857024284;7807.843843123134;7973.800654983628;7707.22927707229;7856.92143078569;7861.80345491363;7868.606569671522;7871.134175240719;2212.933611991643;2242.4505996030994;2242.6299660555987;2243.181238847817;2245.393743689203;2172.0985790896757;2195.890205489719;2201.2295696506253;2203.889805509726;2206.889655517226;2176.542925985537;2181.2365672014826;2182.6725991101302;2186.223890518867;2221.577900198957;2153.192552792703;2154.967675484869;2158.6222411077997;2160.7083043789044;2161.0923412166926;2119.1205649655376;2161.91352345906;2162.0919213930188;2162.3188695561007;2162.9567408651897;7631.618419079024;7762.9611851940945;7777.144514103444;7840.686372545091;7940.483868548526;4564.589186973155;4702.059588082398;4703.952960470386;4705.200115980291;4705.811767529295;2785.7353551412584;2837.6878543360212;2903.9400618773993;2904.114245155227;2906.3024874030293;920.8987011428737;936.7611259128946;953.5184731710442;954.5847556313026;955.5174636808437;10607.681769546925;10680.519376627994;10704.304220225738;10735.624253151102;10737.677869663923;3885.6891448684037;4010.859619913289;4121.258173528794;4124.1133156371525;4181.289180839264;8349.874751878726;8403.70587029451;8417.116202798617;8423.199796019368;8424;4597.034622729264;4607.055553611502;4608.193566125915;4609;4617.215073437524;3552.1652411683235;4085.4076158956786;4225.049363893099;4289.1421715657;4294.3558466230315;3473.5484387029524;3505.2463720300257;3551.94672079919;3582.2477279771538;3671.2290419011774;1068.9946550267198;1071.2875937501474;1076.2940738928885;1082.5561519776854;1088.259983211408;618.8050764009323;662.483263054818;715.0704084689883;715.3740477082553;757.4659864795416;4832.1543729847135;4842.782074806642;4965.553100220997;5014.849554513297;5297.046531624344;834.770438129507;852.0754980845728;873.6199753107419;893.6916763716507;906.5603182456504;3224.8387580620874;3483.111806489329;3526.6297038810553;3534.1164708822794;3542.1144713821545;9445.90554094464;9733.951330243444;9867.259955503223;9869.457179855177;9875.802483950281;9748.46383448903;9754.317197796228;9766.46284454362;9776.9022309776;9777.755556111011;7253.601051942193;7309.5248808827255;7376.96311518439;7383.003294555167;7386.187519372865;5163.561097306771;5194.506521880416;5300.681959082467;5392.218128371285;5470.562355011669;8616.741497755078;9076.047015063323;9082.500462474627;9088.272938165062;9090.454572725657;8926.419782714103;9036.593353298986;9053.90946090557;9100.635974560944;9394.577244024173;5864.237649105759;6047.455728984412;6051.940910340761;6622.072909792537;6778.491613129134;6745.258021617717;6752.628605426552;7462.589557574385;7503.13713922884;7648.34989025939;6765.1205343305055;6844.93155068443;6895.827604309732;6942.722291108501;6943.305669433218;6725.226598941184;6791.490638202254;6808.693608787517;6890.517663763689;6914.343137401939;5581.804636837691;5590.385057643574;5631.774729010794;5632.211490391431;5637.718114094361;4279.2083464559155;4359.912801743884;4378.6278166356215;4476.619487343482;4480.663950203682;4116.115035267432;4361.228677060868;4477.037436951071;4490.663200260059;4534.433195850519 15:06:39 INFO - PROCESS | 26754 | |4;prototype.html;284.1277278754225;285.7199944054825;298.6341731379061;306.3184414677342;306.3612368212278;4916.483769204236;4940.876478088041;4952.603791696664;4968.652194346397;4986.476419975905;4612.262038073909;4656.557627025436;4772.976135119328;4786.641001924852;4884.145274576953;3830.5403351597847;3855.4602355670227;3857.537095548524;3890.1247219375696;3891.3190191716476;3830.712696547756;3859.1702783901455;3865.1303456722294;3868.5744568097625;3891.8832435026993;3637.6362363763546;3711.6845068169237;3790.564085130204;3794.8236046825436;3799;3771.358868992278;3779.149691319445;3805.2009078093356;3806.2958352704563;3813.199228162089;3370.9157271068175;3375.4261775498226;3386.9491957620407;3387.5765529308837;3402.625711171769;4510.684252102355;4706.952930470686;4747.098051370229;4755.144074066667;4758.286257061434;4240.830366785325;4270.338097594878;4319.287317592593;4330.242207613655;4336.588024137702;5094.286799848024;5102.311187989611;5108.463611320795;5127.333446651912;5128.358955130609;3510.262844802569;3589.77947497852;3600.279944011208;3602.873899413508;3604.4593311003296;5233;5302.310699609065;5316;5323.121684922022;5336.3329583802415;3634.3639863024396;3656.9817150914073;3658.2683463307444;3667.7982710951155;3675.9448608270895;3711.3690672585726;3722.553293604785;3723.1250656095795;3737.6075512070843;3740.775553466801;4088.529819070845;4260;4265.594768496988;4310.439642846472;4312.633426158749;5032.119379108642;5043.218301163325;5044.949550504448;5052.873678158076;5059.709774007678;1201.8317435558854;1260.6407173955379;1277.6678063703505;1280.7886698694797;1302.6482849630547;861.7199410191713;864.4683519635379;882.1927935938544;884.2174675412178;889.3952112563519;4329.177456283296;4344.348347747863;4348.7390756554705;4353.6299414549485;4360.345948107809;5148.819791307361;5164.8192313268855;5170.793168273227;5184.248283998799;5193.4027586828;4305.225059489259;4320.487829259734;4348.391225228471;4348.7390756554705;4357;2330.7203135623495;2424.1273141668985;2447.926562203101;2467.469494058786;2482.6524286599893;4305.569443055732;4321.632661223768;4321.978390108092;4373.671974601918;4376.737395756201;4656.674032817738;4698.600618947359;4711.528847115261;4720.433547974265;4733.443940272284;4072.714909956334;4277.935830962538;4344.847930322424;4370.519242883344;4373.343998400265;4525.253333200117;4553.521880202531;4555.020670555714;4580.496145423934;4649.139909116824;4486.304622783474;4502.887427814331;4505.6395488360195;4543.727376357429;4544.204764166324;4021.436998820109;4305.720128191658;4312.245357062564;4322.5677432256525;4341.3487976803735;3388.881389151368;3390.71178949792;3410.795352278871;3427.7771944823508;3432.056184549269;4692.507286734844;4706.529347065266;4762.9523704762505;4771.976140119277;5032.62255330859;4953.380827396575;5016.623753218596;5062.443131255633;5068.352785344704;5069.403138011515;5043.839916819079;5049.873753156054;5072.5688316493515;5077.720725360141;5082.567981721447;4869.537393947569;4982.451930287593;5006.498050584883;5018.949810501848;5034.798608055637;5056.014077255047;5058.949410505995;5061.190209566452;5074.264231686311;5077.060743762416;4952.925706114484;4958.057968986025;4991.57571606403;4992.15133427311;5014.097462456647 15:06:39 INFO - PROCESS | 26754 | |5;yui.html;674.2448457727345;690.2683155854794;700.2717174138896;738.7488253993641;779.438804061076;12478.25130492171;12510.374481275934;13716.725665486696;13722.725545489084;13736.313184340794;12727.872721272784;12865.16376435531;12865.678358041054;12941.805872911913;12972.351382430888;628.4689437425368;777.9299863012328;796.1958421993799;798.9680412783482;799.448380617375;645.4449173710605;646.0728854094366;653.4413076819322;653.7352372289231;770.3836930455641;830.6054624053587;839.3872473094644;839.8488272111048;840.0968958369747;840.794005468661;835.2274146414572;837.9874301885477;838.0153319849214;838.1241602525375;838.4508147163617;477.43900916423064;591.1871177131444;602.5601311042964;613.9938600613981;614.6066517428804;13226.404811783397;13254.138480998801;13283.468661253539;13294.534691285759;13321.400536975763;12614.117011809178;12868.87131128686;13047.934760326138;13132.277724725136;13518.797218041638;12032.39838008105;12083.758324833454;12103.455344509519;12136.514539418413;12403.13178077535;4108.91782164358;4155.646770024551;4189.601987811153;4206.600372964564;4240.321548552217;60104;60194.398056019316;60224;60267;60415;10188;10248.38509689406;10503.107235885036;10794.56821727122;10841.83737243942;19274.22903083861;19366.70949935752;19381.03094845252;19405.32081377145;19425.222991080198;6985.476089293324;7039.788806335818;7098.929010709827;7123.821904452327;7139.428845692332;3565.625609310985;3601.081724160322;3616.0959760059986;3624.8550057997386;3629.6551827576336;2902.796804223726;2966.9258268543026;2989.536621823621;2995.266159790865;3009.879604815783;473.96919200251875;474.6321600759439;478.09878379255355;497.24915377779814;497.6566169343142;482.9396325459318;491.8991606720614;513.7636687123965;519.4675457655858;531.5614617940215;7483.203721635955;7548.4716069874585;7692.884606730903;7703.383729301642;7718.691252349955;507.79434329096773;516.633190434788;527.5146864884316;530.3900514408462;556.2851735519838;3479.59984601774;3715.684166845794;3721.813909304524;3724.1248306647917;3750.6249375062275;68376;94970.52514737382;96405;96485.51757241169;96637.51681241549;49302.26046609304;55392.72303638456;87022.56488717643;88110.55944720235;88533.55733221292;75280;75490.62254688801;75571;75652.24347756561;76956;6673.9666301668185;7100.396466300423;7179.461540384387;7180;7268.236835132235;31680.5247921286;43672;44583.10833783371;44606;45443.7727811372;36252.09369765777;37282.81358593189;37393.439098413;58171.41828581829;61746.38253617586;9143.817123657622;9264.53677316118;9288.767780805534;9389.24886009104;9466.810663786548;9706.320557560903;9884.950575247078;9894.505274736379;10056.497175141067;10240.180785537288;9053.818923621622;9276.397034193025;9514.001029891762;9608.13526782565;9719.125278724949;9208.3093767969;9209.539523023956;9216.861747073934;9344.299177561574;9612.66355677548;8252.917470825216;8257.876131857907;8278.296344810758;8289;8424.62089205975;7795.610219489116;7808.258215469521;7828.882566761617;7832.337005418185;8144.633491492778;6932.445404367538;7135.964320178574;7231.240719724564;7266.309700578437;7301.853962920605 15:06:39 INFO - PROCESS | 26754 | __end_tp_report 15:06:39 INFO - PROCESS | 26754 | __start_cc_report 15:06:39 INFO - PROCESS | 26754 | _x_x_mozilla_cycle_collect,1089 15:06:39 INFO - PROCESS | 26754 | __end_cc_report 15:06:39 INFO - PROCESS | 26754 | __startTimestamp1467929199963__endTimestamp 15:06:39 INFO - PROCESS | 26754 | 15:06:39 INFO - PROCESS | 26754 | ------- Summary: start ------- 15:06:39 INFO - PROCESS | 26754 | Number of tests: 6 15:06:39 INFO - PROCESS | 26754 | 15:06:39 INFO - PROCESS | 26754 | [#0] dojo.html Cycles:165 Average:4689.41 Median:4822.16 stddev:495.85 (10.3%) stddev-sans-first:468.98 15:06:39 INFO - PROCESS | 26754 | Values: 2581.5 2587.9 2608.0 2618.6 2624.6 4681.9 4695.1 4696.8 4702.8 4754.9 4707.4 4709.1 4737.5 4802.7 4812.5 4284.4 4284.6 4360.1 4361.8 4383.0 4421.0 4467.9 4487.9 4490.8 4507.5 4310.5 4366.5 4372.1 4390.0 4418.9 4403.7 4419.9 4420.7 4422.0 4422.3 4384.5 4394.9 4395.2 4395.3 4406.2 4653.8 4725.7 4771.6 4778.2 4785.1 5033.5 5040.8 5043.7 5049.6 5093.8 5092.7 5123.5 5142.0 5160.7 5163.7 4667.6 4715.4 4758.0 4773.7 4822.2 5256.3 5305.4 5315.3 5315.6 5323.6 4850.3 5069.5 5084.6 5088.9 5091.8 4967.1 4981.5 5001.8 5061.5 5088.8 4961.7 4969.8 4970.7 4979.8 5022.6 4870.5 4912.5 4917.2 4921.0 4932.9 4312.8 4358.7 4370.2 4375.7 4419.7 3737.2 3773.6 3784.3 3800.2 3815.2 4206.4 4296.4 4309.8 4343.1 4357.1 5039.0 5082.6 5086.3 5120.8 5123.3 4255.2 4274.7 4293.6 4341.0 4343.0 4469.2 4532.0 4596.6 4599.2 4601.2 4744.5 4748.6 4775.5 4821.5 4828.5 5129.0 5132.1 5136.8 5141.7 5186.4 4582.0 4658.0 4764.5 4775.0 4823.5 4879.1 4980.3 5000.4 5001.2 5056.5 5030.3 5039.9 5061.0 5062.8 5086.1 4838.2 4878.6 4894.8 4908.5 4919.5 4960.8 4973.0 4982.6 4982.7 5018.6 4912.4 4919.7 4957.6 4970.4 4971.0 4895.1 4914.8 4961.4 4973.4 5000.6 4879.2 4880.4 4903.2 4904.5 4939.4 15:06:39 INFO - PROCESS | 26754 | 15:06:39 INFO - PROCESS | 26754 | [#1] ext.html Cycles:180 Average:45330.44 Median:35716.05 stddev:76034.49 (212.9%) stddev-sans-first:76173.52 15:06:39 INFO - PROCESS | 26754 | Values: 570.6 578.3 581.4 585.8 595.6 27032.2 27597.2 29733.3 29780.9 40390.6 40971.8 45704.8 46579.5 46656.5 46683.3 7688.4 7831.5 7831.8 7834.5 7835.1 7583.3 7755.3 7844.9 9936.1 10178.9 10069.2 10113.4 10125.1 10135.9 10149.7 10144.8 10208.3 10212.5 10221.6 10223.7 10041.2 10083.5 10089.6 10102.4 10114.5 39719.8 40042.6 40146.6 40175.6 40185.8 2927.6 3064.4 3271.3 3297.9 3692.6 30223.8 30564.4 31018.1 31187.8 31234.5 3607.8 3631.5 3643.7 3646.8 3752.5 257978.0 260737.0 260967.0 261415.0 261574.7 52922.0 53254.0 53273.2 53362.5 53370.2 57986.4 58036.0 58049.7 58076.1 58208.4 13346.3 13849.0 13892.5 13903.9 13965.1 9132.8 10224.6 10270.6 10294.8 10295.8 16491.9 16870.2 16950.6 17584.6 17606.6 6254.6 6255.2 6288.5 6566.1 6579.9 840.9 891.7 923.2 945.8 953.6 28363.6 28794.0 28865.7 29353.0 29432.9 956.7 1001.5 1004.4 1008.1 1029.8 14601.1 15231.3 15309.9 15400.8 15490.0 355869.0 358208.0 362562.0 362916.0 362957.0 49138.8 49332.8 49370.8 49389.3 49412.0 1042.4 1163.4 1200.1 1208.5 1211.4 28680.9 29743.3 29858.0 29882.0 30066.8 42566.8 42718.0 43226.6 43251.6 43268.4 234090.0 234584.0 234886.0 234950.0 235265.0 31115.7 32299.0 36115.0 37179.0 37215.4 41225.6 41970.4 42030.4 42587.6 42641.6 36769.0 36953.0 37199.8 37551.4 37885.6 35794.8 36265.8 37065.3 37178.3 37514.2 35637.3 35980.5 36592.3 36687.3 36789.6 30222.5 34106.8 34279.1 34506.5 34521.0 25746.4 25840.2 25869.2 26203.9 26257.5 15:06:39 INFO - PROCESS | 26754 | 15:06:39 INFO - PROCESS | 26754 | [#2] jquery.html Cycles:180 Average:23363.63 Median:2146.92 stddev:59689.71 (2780.2%) stddev-sans-first:59832.14 15:06:39 INFO - PROCESS | 26754 | Values: 345.9 367.6 373.7 373.8 390.6 12933.7 16431.2 16806.2 16980.7 17884.7 16859.4 17100.2 17256.8 17457.5 17664.6 5049.9 5271.0 5553.5 5560.3 5649.5 3376.7 5114.8 5364.4 5373.1 5615.0 5426.1 5431.3 5435.8 5451.1 5455.2 5284.4 5326.9 5407.9 5411.9 5434.8 3280.3 4982.8 5262.2 5278.4 5278.8 11581.3 11704.4 11833.7 11867.8 20300.6 1814.2 1874.8 1896.1 1923.1 1950.2 9197.4 9330.8 9392.7 9459.7 10771.4 1759.8 1768.9 1771.1 1775.6 1795.1 69508.7 73803.0 74257.0 74495.6 74603.6 8901.5 9067.1 10013.1 10148.5 10571.8 11302.3 12035.5 12052.4 12258.3 12288.5 6851.2 6957.7 7016.3 7113.9 7134.1 6756.7 6851.1 6893.9 6928.9 6980.8 3862.8 3871.1 3903.3 3943.5 4020.0 1690.2 1755.5 1765.5 1770.4 1770.6 879.6 903.6 922.6 950.7 971.5 16501.7 17218.7 17219.7 17306.8 17751.5 857.9 873.6 884.9 911.4 912.2 9121.9 9694.3 9696.4 9701.1 9807.1 354741.0 357606.0 359563.0 359865.0 361052.0 76941.0 79739.6 79994.2 80601.6 81813.6 858.2 868.3 870.1 871.6 871.9 14720.7 15196.5 15280.2 15345.4 15784.6 36680.4 36781.0 37657.8 38227.4 38488.2 51411.2 53384.0 53940.5 54007.5 54054.7 4631.9 4732.9 7389.7 7449.0 7527.4 10606.5 11400.4 11435.4 11485.1 11638.2 9900.0 10253.2 10375.5 10441.9 10443.7 10064.6 10086.9 10130.7 10151.9 10300.3 10177.9 10448.2 10543.6 10543.7 10642.7 7290.6 7362.1 7427.9 7476.1 7565.0 8029.4 10153.8 10257.1 10260.3 10309.1 15:06:39 INFO - PROCESS | 26754 | 15:06:39 INFO - PROCESS | 26754 | [#3] mootools.html Cycles:180 Average:5068.21 Median:5245.78 stddev:2874.54 (54.8%) stddev-sans-first:2868.29 15:06:39 INFO - PROCESS | 26754 | Values: 1250.3 1373.4 1412.0 1505.8 1732.5 6720.6 7570.1 7804.8 7807.8 7973.8 7707.2 7856.9 7861.8 7868.6 7871.1 2212.9 2242.5 2242.6 2243.2 2245.4 2172.1 2195.9 2201.2 2203.9 2206.9 2176.5 2181.2 2182.7 2186.2 2221.6 2153.2 2155.0 2158.6 2160.7 2161.1 2119.1 2161.9 2162.1 2162.3 2163.0 7631.6 7763.0 7777.1 7840.7 7940.5 4564.6 4702.1 4704.0 4705.2 4705.8 2785.7 2837.7 2903.9 2904.1 2906.3 920.9 936.8 953.5 954.6 955.5 10607.7 10680.5 10704.3 10735.6 10737.7 3885.7 4010.9 4121.3 4124.1 4181.3 8349.9 8403.7 8417.1 8423.2 8424.0 4597.0 4607.1 4608.2 4609.0 4617.2 3552.2 4085.4 4225.0 4289.1 4294.4 3473.5 3505.2 3551.9 3582.2 3671.2 1069.0 1071.3 1076.3 1082.6 1088.3 618.8 662.5 715.1 715.4 757.5 4832.2 4842.8 4965.6 5014.8 5297.0 834.8 852.1 873.6 893.7 906.6 3224.8 3483.1 3526.6 3534.1 3542.1 9445.9 9734.0 9867.3 9869.5 9875.8 9748.5 9754.3 9766.5 9776.9 9777.8 7253.6 7309.5 7377.0 7383.0 7386.2 5163.6 5194.5 5300.7 5392.2 5470.6 8616.7 9076.0 9082.5 9088.3 9090.5 8926.4 9036.6 9053.9 9100.6 9394.6 5864.2 6047.5 6051.9 6622.1 6778.5 6745.3 6752.6 7462.6 7503.1 7648.3 6765.1 6844.9 6895.8 6942.7 6943.3 6725.2 6791.5 6808.7 6890.5 6914.3 5581.8 5590.4 5631.8 5632.2 5637.7 4279.2 4359.9 4378.6 4476.6 4480.7 4116.1 4361.2 4477.0 4490.7 4534.4 15:06:39 INFO - PROCESS | 26754 | 15:06:39 INFO - PROCESS | 26754 | [#4] prototype.html Cycles:180 Average:4076.63 Median:4365.43 stddev:1176.14 (26.9%) stddev-sans-first:1144.48 15:06:39 INFO - PROCESS | 26754 | Values: 284.1 285.7 298.6 306.3 306.4 4916.5 4940.9 4952.6 4968.7 4986.5 4612.3 4656.6 4773.0 4786.6 4884.1 3830.5 3855.5 3857.5 3890.1 3891.3 3830.7 3859.2 3865.1 3868.6 3891.9 3637.6 3711.7 3790.6 3794.8 3799.0 3771.4 3779.1 3805.2 3806.3 3813.2 3370.9 3375.4 3386.9 3387.6 3402.6 4510.7 4707.0 4747.1 4755.1 4758.3 4240.8 4270.3 4319.3 4330.2 4336.6 5094.3 5102.3 5108.5 5127.3 5128.4 3510.3 3589.8 3600.3 3602.9 3604.5 5233.0 5302.3 5316.0 5323.1 5336.3 3634.4 3657.0 3658.3 3667.8 3675.9 3711.4 3722.6 3723.1 3737.6 3740.8 4088.5 4260.0 4265.6 4310.4 4312.6 5032.1 5043.2 5044.9 5052.9 5059.7 1201.8 1260.6 1277.7 1280.8 1302.6 861.7 864.5 882.2 884.2 889.4 4329.2 4344.3 4348.7 4353.6 4360.3 5148.8 5164.8 5170.8 5184.2 5193.4 4305.2 4320.5 4348.4 4348.7 4357.0 2330.7 2424.1 2447.9 2467.5 2482.7 4305.6 4321.6 4322.0 4373.7 4376.7 4656.7 4698.6 4711.5 4720.4 4733.4 4072.7 4277.9 4344.8 4370.5 4373.3 4525.3 4553.5 4555.0 4580.5 4649.1 4486.3 4502.9 4505.6 4543.7 4544.2 4021.4 4305.7 4312.2 4322.6 4341.3 3388.9 3390.7 3410.8 3427.8 3432.1 4692.5 4706.5 4763.0 4772.0 5032.6 4953.4 5016.6 5062.4 5068.4 5069.4 5043.8 5049.9 5072.6 5077.7 5082.6 4869.5 4982.5 5006.5 5018.9 5034.8 5056.0 5058.9 5061.2 5074.3 5077.1 4952.9 4958.1 4991.6 4992.2 5014.1 15:06:39 INFO - PROCESS | 26754 | 15:06:39 INFO - PROCESS | 26754 | [#5] yui.html Cycles:180 Average:16289.72 Median:30514.50 stddev:23644.28 (77.5%) stddev-sans-first:23681.53 15:06:39 INFO - PROCESS | 26754 | Values: 674.2 690.3 700.3 738.7 779.4 12478.3 12510.4 13716.7 13722.7 13736.3 12727.9 12865.2 12865.7 12941.8 12972.4 628.5 777.9 796.2 799.0 799.4 645.4 646.1 653.4 653.7 770.4 830.6 839.4 839.8 840.1 840.8 835.2 838.0 838.0 838.1 838.5 477.4 591.2 602.6 614.0 614.6 13226.4 13254.1 13283.5 13294.5 13321.4 12614.1 12868.9 13047.9 13132.3 13518.8 12032.4 12083.8 12103.5 12136.5 12403.1 4108.9 4155.6 4189.6 4206.6 4240.3 60104.0 60194.4 60224.0 60267.0 60415.0 10188.0 10248.4 10503.1 10794.6 10841.8 19274.2 19366.7 19381.0 19405.3 19425.2 6985.5 7039.8 7098.9 7123.8 7139.4 3565.6 3601.1 3616.1 3624.9 3629.7 2902.8 2966.9 2989.5 2995.3 3009.9 474.0 474.6 478.1 497.2 497.7 482.9 491.9 513.8 519.5 531.6 7483.2 7548.5 7692.9 7703.4 7718.7 507.8 516.6 527.5 530.4 556.3 3479.6 3715.7 3721.8 3724.1 3750.6 68376.0 94970.5 96405.0 96485.5 96637.5 49302.3 55392.7 87022.6 88110.6 88533.6 75280.0 75490.6 75571.0 75652.2 76956.0 6674.0 7100.4 7179.5 7180.0 7268.2 31680.5 43672.0 44583.1 44606.0 45443.8 36252.1 37282.8 37393.4 58171.4 61746.4 9143.8 9264.5 9288.8 9389.2 9466.8 9706.3 9885.0 9894.5 10056.5 10240.2 9053.8 9276.4 9514.0 9608.1 9719.1 9208.3 9209.5 9216.9 9344.3 9612.7 8252.9 8257.9 8278.3 8289.0 8424.6 7795.6 7808.3 7828.9 7832.3 8144.6 6932.4 7136.0 7231.2 7266.3 7301.9 15:06:39 INFO - PROCESS | 26754 | -------- Summary: end -------- 15:06:39 INFO - PROCESS | 26754 | 15:06:40 INFO - TEST-INFO | 26754: exit 0 15:06:40 INFO - TEST-OK | dromaeo_css | took 1119505ms 15:06:40 INFO - TEST-START | kraken 15:06:40 INFO - operating with platform_type : linux_ 15:06:40 INFO - Initialising browser for kraken test... 15:06:40 INFO - TEST-INFO | started process 26945 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdVNau0/profile http://localhost:51202/getInfo.html) 15:06:44 INFO - PROCESS | 26945 | __metrics Screen width/height:1600/1200 15:06:44 INFO - PROCESS | 26945 | colorDepth:24 15:06:44 INFO - PROCESS | 26945 | Browser inner width/height: 1024/697 15:06:44 INFO - PROCESS | 26945 | __metrics 15:06:45 INFO - PROCESS | 26945 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:06:46 INFO - TEST-INFO | 26945: exit 0 15:06:46 INFO - Browser initialized. 15:06:46 INFO - Running cycle 1/1 for kraken test... 15:06:46 INFO - TEST-INFO | started process 27025 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdVNau0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:06:58 INFO - PROCESS | 27025 | RSS: Main: 158302208 15:06:58 INFO - PROCESS | 27025 | 15:07:01 INFO - PROCESS | 27025 | Cycle 1(1): loaded http://localhost:51202/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51202/tests/kraken/driver.html?testName=audio-beat-detection) 15:07:02 INFO - PROCESS | 27025 | RSS: Main: 217071616 15:07:02 INFO - PROCESS | 27025 | 15:07:05 INFO - PROCESS | 27025 | Cycle 1(1): loaded http://localhost:51202/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51202/tests/kraken/driver.html?testName=audio-dft) 15:07:05 INFO - PROCESS | 27025 | RSS: Main: 204963840 15:07:05 INFO - PROCESS | 27025 | 15:07:08 INFO - PROCESS | 27025 | Cycle 1(1): loaded http://localhost:51202/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51202/tests/kraken/driver.html?testName=audio-fft) 15:07:09 INFO - PROCESS | 27025 | RSS: Main: 271294464 15:07:09 INFO - PROCESS | 27025 | 15:07:11 INFO - PROCESS | 27025 | Cycle 1(1): loaded http://localhost:51202/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51202/tests/kraken/driver.html?testName=audio-oscillator) 15:07:12 INFO - PROCESS | 27025 | RSS: Main: 181678080 15:07:12 INFO - PROCESS | 27025 | 15:07:14 INFO - PROCESS | 27025 | Cycle 1(1): loaded http://localhost:51202/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51202/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:07:15 INFO - PROCESS | 27025 | RSS: Main: 185753600 15:07:15 INFO - PROCESS | 27025 | 15:07:18 INFO - PROCESS | 27025 | Cycle 1(1): loaded http://localhost:51202/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51202/tests/kraken/driver.html?testName=imaging-darkroom) 15:07:18 INFO - PROCESS | 27025 | RSS: Main: 222130176 15:07:18 INFO - PROCESS | 27025 | 15:07:22 INFO - PROCESS | 27025 | Cycle 1(1): loaded http://localhost:51202/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51202/tests/kraken/driver.html?testName=imaging-desaturate) 15:07:22 INFO - PROCESS | 27025 | RSS: Main: 222806016 15:07:22 INFO - PROCESS | 27025 | 15:07:25 INFO - PROCESS | 27025 | Cycle 1(1): loaded http://localhost:51202/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51202/tests/kraken/driver.html?testName=json-parse-financial) 15:07:26 INFO - PROCESS | 27025 | RSS: Main: 222351360 15:07:26 INFO - PROCESS | 27025 | 15:07:28 INFO - PROCESS | 27025 | Cycle 1(1): loaded http://localhost:51202/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51202/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:07:28 INFO - PROCESS | 27025 | RSS: Main: 208146432 15:07:28 INFO - PROCESS | 27025 | 15:07:30 INFO - PROCESS | 27025 | Cycle 1(1): loaded http://localhost:51202/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51202/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:07:31 INFO - PROCESS | 27025 | RSS: Main: 211533824 15:07:31 INFO - PROCESS | 27025 | 15:07:33 INFO - PROCESS | 27025 | Cycle 1(1): loaded http://localhost:51202/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51202/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:07:34 INFO - PROCESS | 27025 | RSS: Main: 210030592 15:07:34 INFO - PROCESS | 27025 | 15:07:36 INFO - PROCESS | 27025 | Cycle 1(1): loaded http://localhost:51202/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51202/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:07:37 INFO - PROCESS | 27025 | RSS: Main: 224505856 15:07:37 INFO - PROCESS | 27025 | 15:07:40 INFO - PROCESS | 27025 | Cycle 1(1): loaded http://localhost:51202/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51202/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:07:40 INFO - PROCESS | 27025 | RSS: Main: 226099200 15:07:40 INFO - PROCESS | 27025 | 15:07:42 INFO - PROCESS | 27025 | Cycle 1(1): loaded http://localhost:51202/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51202/tests/kraken/driver.html?testName=ai-astar) 15:07:42 INFO - PROCESS | 27025 | RSS: Main: 268722176 15:07:42 INFO - PROCESS | 27025 | 15:07:42 INFO - PROCESS | 27025 | __start_tp_report 15:07:42 INFO - PROCESS | 27025 | _x_x_mozilla_page_load 15:07:42 INFO - PROCESS | 27025 | _x_x_mozilla_page_load_details 15:07:42 INFO - PROCESS | 27025 | |i|pagename|runs| 15:07:42 INFO - PROCESS | 27025 | |0;ai-astar;105;113;114;115;114;116;112;113;114;113 15:07:42 INFO - PROCESS | 27025 | |1;audio-beat-detection;149;122;129;175;121;146;157;124;204;128 15:07:42 INFO - PROCESS | 27025 | |2;audio-dft;169;161;161;159;160;161;162;161;161;160 15:07:42 INFO - PROCESS | 27025 | |3;audio-fft;76;76;76;101;76;76;75;75;99;74 15:07:42 INFO - PROCESS | 27025 | |4;audio-oscillator;85;87;118;85;84;84;126;84;85;117 15:07:42 INFO - PROCESS | 27025 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;118;117;117 15:07:42 INFO - PROCESS | 27025 | |6;imaging-darkroom;147;147;145;146;146;146;146;146;145;145 15:07:42 INFO - PROCESS | 27025 | |7;imaging-desaturate;95;95;95;95;94;95;95;95;95;94 15:07:42 INFO - PROCESS | 27025 | |8;json-parse-financial;64;64;64;65;64;65;65;64;65;65 15:07:42 INFO - PROCESS | 27025 | |9;json-stringify-tinderbox;64;65;65;64;64;64;65;64;64;65 15:07:42 INFO - PROCESS | 27025 | |10;stanford-crypto-aes;77;79;80;77;78;84;77;79;79;83 15:07:42 INFO - PROCESS | 27025 | |11;stanford-crypto-ccm;131;127;138;129;130;126;138;129;203;136 15:07:42 INFO - PROCESS | 27025 | |12;stanford-crypto-pbkdf2;168;167;163;168;164;164;172;167;162;162 15:07:42 INFO - PROCESS | 27025 | |13;stanford-crypto-sha256-iterative;67;67;68;66;69;66;66;67;65;66 15:07:42 INFO - PROCESS | 27025 | __end_tp_report 15:07:42 INFO - PROCESS | 27025 | __start_cc_report 15:07:42 INFO - PROCESS | 27025 | _x_x_mozilla_cycle_collect,1909 15:07:42 INFO - PROCESS | 27025 | __end_cc_report 15:07:42 INFO - PROCESS | 27025 | __startTimestamp1467929262872__endTimestamp 15:07:42 INFO - PROCESS | 27025 | 15:07:42 INFO - PROCESS | 27025 | ------- Summary: start ------- 15:07:42 INFO - PROCESS | 27025 | Number of tests: 14 15:07:42 INFO - PROCESS | 27025 | 15:07:42 INFO - PROCESS | 27025 | [#0] ai-astar Cycles:10 Average:112.90 Median:114.00 stddev:3.00 (2.6%) stddev-sans-first:1.20 15:07:42 INFO - PROCESS | 27025 | Values: 105.0 113.0 114.0 115.0 114.0 116.0 112.0 113.0 114.0 113.0 15:07:42 INFO - PROCESS | 27025 | 15:07:42 INFO - PROCESS | 27025 | [#1] audio-beat-detection Cycles:10 Average:145.50 Median:147.50 stddev:27.14 (18.4%) stddev-sans-first:28.76 15:07:42 INFO - PROCESS | 27025 | Values: 149.0 122.0 129.0 175.0 121.0 146.0 157.0 124.0 204.0 128.0 15:07:42 INFO - PROCESS | 27025 | 15:07:42 INFO - PROCESS | 27025 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.00 stddev:2.76 (1.7%) stddev-sans-first:0.87 15:07:42 INFO - PROCESS | 27025 | Values: 169.0 161.0 161.0 159.0 160.0 161.0 162.0 161.0 161.0 160.0 15:07:42 INFO - PROCESS | 27025 | 15:07:42 INFO - PROCESS | 27025 | [#3] audio-fft Cycles:10 Average:80.40 Median:76.00 stddev:10.36 (13.6%) stddev-sans-first:10.87 15:07:42 INFO - PROCESS | 27025 | Values: 76.0 76.0 76.0 101.0 76.0 76.0 75.0 75.0 99.0 74.0 15:07:42 INFO - PROCESS | 27025 | 15:07:42 INFO - PROCESS | 27025 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:84.50 stddev:17.32 (20.5%) stddev-sans-first:17.94 15:07:42 INFO - PROCESS | 27025 | Values: 85.0 87.0 118.0 85.0 84.0 84.0 126.0 84.0 85.0 117.0 15:07:42 INFO - PROCESS | 27025 | 15:07:42 INFO - PROCESS | 27025 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 15:07:42 INFO - PROCESS | 27025 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 15:07:42 INFO - PROCESS | 27025 | 15:07:42 INFO - PROCESS | 27025 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 15:07:42 INFO - PROCESS | 27025 | Values: 147.0 147.0 145.0 146.0 146.0 146.0 146.0 146.0 145.0 145.0 15:07:42 INFO - PROCESS | 27025 | 15:07:42 INFO - PROCESS | 27025 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 15:07:42 INFO - PROCESS | 27025 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 94.0 15:07:42 INFO - PROCESS | 27025 | 15:07:42 INFO - PROCESS | 27025 | [#8] json-parse-financial Cycles:10 Average:64.50 Median:65.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 15:07:42 INFO - PROCESS | 27025 | Values: 64.0 64.0 64.0 65.0 64.0 65.0 65.0 64.0 65.0 65.0 15:07:42 INFO - PROCESS | 27025 | 15:07:42 INFO - PROCESS | 27025 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 15:07:42 INFO - PROCESS | 27025 | Values: 64.0 65.0 65.0 64.0 64.0 64.0 65.0 64.0 64.0 65.0 15:07:42 INFO - PROCESS | 27025 | 15:07:42 INFO - PROCESS | 27025 | [#10] stanford-crypto-aes Cycles:10 Average:79.30 Median:79.00 stddev:2.45 (3.1%) stddev-sans-first:2.46 15:07:42 INFO - PROCESS | 27025 | Values: 77.0 79.0 80.0 77.0 78.0 84.0 77.0 79.0 79.0 83.0 15:07:42 INFO - PROCESS | 27025 | 15:07:42 INFO - PROCESS | 27025 | [#11] stanford-crypto-ccm Cycles:10 Average:138.70 Median:133.50 stddev:23.01 (17.2%) stddev-sans-first:24.23 15:07:42 INFO - PROCESS | 27025 | Values: 131.0 127.0 138.0 129.0 130.0 126.0 138.0 129.0 203.0 136.0 15:07:42 INFO - PROCESS | 27025 | 15:07:42 INFO - PROCESS | 27025 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.70 Median:167.00 stddev:3.23 (1.9%) stddev-sans-first:3.32 15:07:42 INFO - PROCESS | 27025 | Values: 168.0 167.0 163.0 168.0 164.0 164.0 172.0 167.0 162.0 162.0 15:07:42 INFO - PROCESS | 27025 | 15:07:42 INFO - PROCESS | 27025 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:1.16 (1.7%) stddev-sans-first:1.22 15:07:42 INFO - PROCESS | 27025 | Values: 67.0 67.0 68.0 66.0 69.0 66.0 66.0 67.0 65.0 66.0 15:07:42 INFO - PROCESS | 27025 | -------- Summary: end -------- 15:07:42 INFO - PROCESS | 27025 | 15:07:43 INFO - TEST-INFO | 27025: exit 0 15:07:43 INFO - TEST-OK | kraken | took 63200ms 15:07:43 INFO - SUITE-END | took 1182s 15:07:44 INFO - Completed test suite (00:19:42) 15:07:44 INFO - javascript benchmark 15:07:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2581.457893842293, 2587.9482410351793, 2608.035027039995, 2618.554845676235, 2624.632551442797, 4681.9063618727605, 4695.060987802436, 4696.765161741912, 4702.764861756916, 4754.857354279368, 4707.411573553306, 4709.0581883623245, 4737.455192652846, 4802.687825291354, 4812.518748125186, 4284.4216030835905, 4284.635805956497, 4360.106178233455, 4361.847335343264, 4382.978085109586, 4421.0494743630115, 4467.88830279244, 4487.932681009787, 4490.820367185309, 4507.504174540798, 4310.48274207094, 4366.541513141106, 4372.060007098489, 4390.0, 4418.9337159942625, 4403.735775853459, 4419.933700994456, 4420.7126536775, 4422.027154026109, 4422.270325396305, 4384.517703052662, 4394.934075988863, 4395.1868904252815, 4395.340698895159, 4406.206882761102, 4653.790579423934, 4725.716457012556, 4771.594414474774, 4778.235482322812, 4785.066911952171, 5033.546980771748, 5040.823571175028, 5043.672161309503, 5049.596032317406, 5093.821716239914, 5092.668976516515, 5123.487651234884, 5141.997310524449, 5160.690358578498, 5163.741812909339, 4667.603253723403, 4715.434147902273, 4757.976210118927, 4773.66584339093, 4822.156122678517, 5256.2904007959205, 5305.4164041955355, 5315.28243687105, 5315.6279060465395, 5323.6273460857365, 4850.345203397566, 5069.467705890902, 5084.618653600995, 5088.872778180576, 5091.821786237538, 4967.130752118364, 4981.501849815062, 5001.799928002839, 5061.544460998528, 5088.77100530477, 4961.727105009187, 4969.82605608802, 4970.701757894538, 4979.825706100269, 5022.59819214462, 4870.488598697157, 4912.459629440758, 4917.164082106051, 4921.0, 4932.90134197314, 4312.762798046075, 4358.6730995175485, 4370.169667763115, 4375.7155784873885, 4419.690621656453, 3737.2338670572467, 3773.603771603942, 3784.3377408953324, 3800.220954704279, 3815.236952609489, 4206.390073439334, 4296.355546667963, 4309.806058727365, 4343.109662519176, 4357.063231405263, 5038.974805125951, 5082.567981721595, 5086.338775959101, 5120.795168193231, 5123.257127716534, 4255.234057869551, 4274.679399045084, 4293.613574778223, 4340.956590434118, 4342.9782851086175, 4469.217886869785, 4531.977340113278, 4596.5863072323655, 4599.195140850405, 4601.240795268744, 4744.501827308221, 4748.643851711205, 4775.450823155243, 4821.54195351441, 4828.517148285144, 5128.974355128201, 5132.10188217068, 5136.7945282189785, 5141.691498510101, 5186.429492755869, 4581.977090114661, 4657.953420465888, 4764.49972752856, 4775.044991001744, 4823.493533179106, 4879.146149423766, 4980.252962055721, 5000.399952005637, 5001.249812528004, 5056.519630635084, 5030.270610761492, 5039.899202015866, 5061.0, 5062.848114556569, 5086.109930762176, 4838.225883858566, 4878.56092951636, 4894.828680996148, 4908.533689299511, 4919.508049195052, 4960.751962401938, 4972.975135124301, 4982.551570358685, 4982.676126051795, 5018.598512118949, 4912.435069966857, 4919.729414882216, 4957.553820156203, 4970.428400733817, 4971.0, 4895.069936712013, 4914.778834952364, 4961.42943561495, 4973.378327709036, 5000.6249531284575, 4879.243717223836, 4880.389951256093, 4903.16646170159, 4904.460509343898, 4939.357883475125], "value": 4657.099891107071, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.5920267009088, 578.2771535580524, 581.3982528083432, 585.8271809816104, 595.603923390945, 27032.189034328952, 27597.172084837435, 29733.256668583243, 29780.851095744518, 40390.59609403912, 40971.795141024326, 45704.771476142574, 46579.534204658026, 46656.533434665645, 46683.299750503684, 7688.384929205678, 7831.451798374116, 7831.804204894866, 7834.451588388815, 7835.138134805167, 7583.279588439117, 7755.26324999127, 7844.882326765103, 9936.105750482455, 10178.89821101787, 10069.244806639495, 10113.443760593165, 10125.139363154103, 10135.89864101357, 10149.746256343613, 10144.847827282596, 10208.285420020602, 10212.489375531193, 10221.642242521513, 10223.693289201261, 10041.246906482043, 10083.546240419199, 10089.646862359856, 10102.39385636864, 10114.54484548197, 39719.8014009931, 40042.59957400447, 40146.59853401458, 40175.59824401748, 40185.79907100475, 2927.6194094767757, 3064.4024415239037, 3271.345730853815, 3297.9340413191603, 3692.6122757110384, 30223.848880755457, 30564.38871222563, 31018.0694579163, 31187.84406077955, 31234.53148202779, 3607.801570913599, 3631.455281707739, 3643.708503319728, 3646.81765911706, 3752.4558938953974, 257978.0, 260737.0, 260967.0, 261415.0, 261574.69212654006, 52922.0, 53254.0, 53273.20090198573, 53362.466375336524, 53370.19944700832, 57986.4201357981, 58036.03567571834, 58049.70975145182, 58076.12885806716, 58208.41791582115, 13346.265955372548, 13849.0, 13892.513762018281, 13903.930480347533, 13965.092269002482, 9132.771680708036, 10224.64213752515, 10270.589176433008, 10294.845577316346, 10295.845562316572, 16491.91754041222, 16870.240839162267, 16950.576235593962, 17584.56038599045, 17606.647867042586, 6254.593451425642, 6255.218097737783, 6288.465480434123, 6566.080748695186, 6579.868402631921, 840.8864803251482, 891.714651311574, 923.1875949164692, 945.8392073347547, 953.6471505542855, 28363.57454638182, 28794.0, 28865.711342886723, 29353.0, 29432.852835735684, 956.7082039977735, 1001.5242759689235, 1004.4023805835516, 1008.1229330482381, 1029.8197815382277, 14601.12393256408, 15231.349342737685, 15309.923450382677, 15400.768988465183, 15490.0, 355869.0, 358208.0, 362562.0, 362916.0, 362957.0, 49138.75430622824, 49332.75333623381, 49370.75314623404, 49389.25916111261, 49412.0, 1042.374575254841, 1163.4182908545897, 1200.0939290835363, 1208.4803534480081, 1211.4003568233782, 28680.856595716887, 29743.25641858971, 29858.0, 29882.0, 30066.84966575153, 42566.78716606397, 42718.0, 43226.567734323515, 43251.567484324754, 43268.35097473478, 234090.0, 234584.0, 234886.0, 234950.0, 235265.0, 31115.68884311128, 32299.0, 36115.0, 37179.0, 37215.441768372955, 41225.587744122175, 41970.37044444397, 42030.36954445625, 42587.57412425836, 42641.57358426376, 36769.0, 36953.0, 37199.81400092982, 37551.43672844964, 37885.62114378821, 35794.82102589471, 36265.818670906476, 37065.258694826494, 37178.25643487169, 37514.249715006095, 35637.287254254254, 35980.46029309615, 36592.26815463729, 36687.26625467422, 36789.63210367862, 30222.54666179965, 34106.82946585251, 34279.143021424665, 34506.48240276448, 34521.0, 25746.356341090872, 25840.22479325623, 25869.22392328233, 26203.868980654974, 26257.474850503266], "value": 18026.252800128495, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.9121064252926, 367.58646522662, 373.67863637271944, 373.8037530296594, 390.56452055957595, 12933.741325173503, 16431.178441077944, 16806.243719032642, 16980.660386792257, 17884.731729024075, 16859.40992065275, 17100.230489627964, 17256.82743172568, 17457.476275711717, 17664.558386040357, 5049.899002019948, 5270.9736451317685, 5553.527950124224, 5560.304961879765, 5649.548036157097, 3376.7129793967542, 5114.820981265657, 5364.409914909357, 5373.086575282211, 5614.9893019256515, 5426.104692725715, 5431.266778984826, 5435.782568697247, 5451.100568406208, 5455.236266922634, 5284.445133260991, 5326.866828329304, 5407.864803379907, 5411.918821217685, 5434.809781657623, 3280.311134661724, 4982.750862456863, 5262.23697563855, 5278.392984806758, 5278.841634750964, 11581.305121692641, 11704.356260405675, 11833.704157396049, 11867.762644747057, 20300.5939881203, 1814.2198854492563, 1874.7656542932134, 1896.0709252466193, 1923.134589434746, 1950.2004178286834, 9197.40216885907, 9330.766730831716, 9392.718218453458, 9459.66891158813, 10771.407572583505, 1759.8416142547105, 1768.929242830298, 1771.052486919492, 1775.5561109722569, 1795.093477793706, 69508.6524567379, 73803.0, 74257.0, 74495.62752186258, 74603.62698186528, 8901.510416927002, 9067.093290671011, 10013.148882344936, 10148.492575371201, 10571.788564228826, 11302.321860688386, 12035.518579256732, 12052.397380130958, 12258.325792081521, 12288.508459661693, 6851.246362900077, 6957.65211739411, 7016.298370162943, 7113.857722845514, 7134.143902731706, 6756.662166891636, 6851.143607049119, 6893.862122757517, 6928.930710692929, 6980.825479363057, 3862.787546684959, 3871.090293780959, 3903.277893589695, 3943.4873466449176, 4020.0, 1690.2393922734818, 1755.5260079778388, 1765.5233087066676, 1770.4246120011048, 1770.64587082584, 879.5514287713312, 903.5617725403174, 922.5940586142076, 950.7432993091965, 971.5385192033868, 16501.669966600602, 17218.655626887394, 17219.741703874453, 17306.826931730775, 17751.46745597634, 857.8970523537215, 873.5850471026212, 884.9292056635454, 911.4121391702315, 912.1972664055588, 9121.863172052424, 9694.272929530314, 9696.418214907128, 9701.126898579021, 9807.117359437685, 354741.0, 357606.0, 359563.0, 359865.0, 361052.0, 76941.0, 79739.60130199311, 79994.20005799868, 80601.59699201466, 81813.59093204496, 858.1718641510972, 868.3313848336871, 870.1211776106052, 871.5729292646685, 871.8822958900467, 14720.705585888436, 15196.544103676908, 15280.15959122259, 15345.386184552493, 15784.60538486547, 36680.449793253654, 36781.0, 37657.81171094127, 38227.42658860064, 38488.2302353957, 51411.2288315683, 53384.0, 53940.460595393546, 54007.459925400246, 54054.729726351114, 4631.907361852812, 4732.929006064981, 7389.7413590524075, 7448.9627551861895, 7527.397808175442, 10606.522706478072, 11400.372979486208, 11435.428228588704, 11485.138614603771, 11638.243514171552, 9899.950500247453, 10253.179745620482, 10375.533101010624, 10441.895581044093, 10443.68668939933, 10064.647737329158, 10086.949565252127, 10130.696079117639, 10151.94924025375, 10300.278980471296, 10177.949110254402, 10448.164146868081, 10543.630972915911, 10543.736406589896, 10642.73393165177, 7290.5625662460425, 7362.079740032496, 7427.888581671171, 7476.065491813523, 7565.016547848964, 8029.397795165269, 10153.847692284475, 10257.076863082359, 10260.333078350182, 10309.123724483203], "value": 7972.943000947717, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1250.312328219479, 1373.402569882101, 1412.0, 1505.7741338799178, 1732.4715961631698, 6720.596764194146, 7570.09158900932, 7804.765857024284, 7807.843843123134, 7973.800654983628, 7707.22927707229, 7856.92143078569, 7861.80345491363, 7868.606569671522, 7871.134175240719, 2212.933611991643, 2242.4505996030994, 2242.6299660555987, 2243.181238847817, 2245.393743689203, 2172.0985790896757, 2195.890205489719, 2201.2295696506253, 2203.889805509726, 2206.889655517226, 2176.542925985537, 2181.2365672014826, 2182.6725991101302, 2186.223890518867, 2221.577900198957, 2153.192552792703, 2154.967675484869, 2158.6222411077997, 2160.7083043789044, 2161.0923412166926, 2119.1205649655376, 2161.91352345906, 2162.0919213930188, 2162.3188695561007, 2162.9567408651897, 7631.618419079024, 7762.9611851940945, 7777.144514103444, 7840.686372545091, 7940.483868548526, 4564.589186973155, 4702.059588082398, 4703.952960470386, 4705.200115980291, 4705.811767529295, 2785.7353551412584, 2837.6878543360212, 2903.9400618773993, 2904.114245155227, 2906.3024874030293, 920.8987011428737, 936.7611259128946, 953.5184731710442, 954.5847556313026, 955.5174636808437, 10607.681769546925, 10680.519376627994, 10704.304220225738, 10735.624253151102, 10737.677869663923, 3885.6891448684037, 4010.859619913289, 4121.258173528794, 4124.1133156371525, 4181.289180839264, 8349.874751878726, 8403.70587029451, 8417.116202798617, 8423.199796019368, 8424.0, 4597.034622729264, 4607.055553611502, 4608.193566125915, 4609.0, 4617.215073437524, 3552.1652411683235, 4085.4076158956786, 4225.049363893099, 4289.1421715657, 4294.3558466230315, 3473.5484387029524, 3505.2463720300257, 3551.94672079919, 3582.2477279771538, 3671.2290419011774, 1068.9946550267198, 1071.2875937501474, 1076.2940738928885, 1082.5561519776854, 1088.259983211408, 618.8050764009323, 662.483263054818, 715.0704084689883, 715.3740477082553, 757.4659864795416, 4832.1543729847135, 4842.782074806642, 4965.553100220997, 5014.849554513297, 5297.046531624344, 834.770438129507, 852.0754980845728, 873.6199753107419, 893.6916763716507, 906.5603182456504, 3224.8387580620874, 3483.111806489329, 3526.6297038810553, 3534.1164708822794, 3542.1144713821545, 9445.90554094464, 9733.951330243444, 9867.259955503223, 9869.457179855177, 9875.802483950281, 9748.46383448903, 9754.317197796228, 9766.46284454362, 9776.9022309776, 9777.755556111011, 7253.601051942193, 7309.5248808827255, 7376.96311518439, 7383.003294555167, 7386.187519372865, 5163.561097306771, 5194.506521880416, 5300.681959082467, 5392.218128371285, 5470.562355011669, 8616.741497755078, 9076.047015063323, 9082.500462474627, 9088.272938165062, 9090.454572725657, 8926.419782714103, 9036.593353298986, 9053.90946090557, 9100.635974560944, 9394.577244024173, 5864.237649105759, 6047.455728984412, 6051.940910340761, 6622.072909792537, 6778.491613129134, 6745.258021617717, 6752.628605426552, 7462.589557574385, 7503.13713922884, 7648.34989025939, 6765.1205343305055, 6844.93155068443, 6895.827604309732, 6942.722291108501, 6943.305669433218, 6725.226598941184, 6791.490638202254, 6808.693608787517, 6890.517663763689, 6914.343137401939, 5581.804636837691, 5590.385057643574, 5631.774729010794, 5632.211490391431, 5637.718114094361, 4279.2083464559155, 4359.912801743884, 4378.6278166356215, 4476.619487343482, 4480.663950203682, 4116.115035267432, 4361.228677060868, 4477.037436951071, 4490.663200260059, 4534.433195850519], "value": 4062.5271726179503, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.1277278754225, 285.7199944054825, 298.6341731379061, 306.3184414677342, 306.3612368212278, 4916.483769204236, 4940.876478088041, 4952.603791696664, 4968.652194346397, 4986.476419975905, 4612.262038073909, 4656.557627025436, 4772.976135119328, 4786.641001924852, 4884.145274576953, 3830.5403351597847, 3855.4602355670227, 3857.537095548524, 3890.1247219375696, 3891.3190191716476, 3830.712696547756, 3859.1702783901455, 3865.1303456722294, 3868.5744568097625, 3891.8832435026993, 3637.6362363763546, 3711.6845068169237, 3790.564085130204, 3794.8236046825436, 3799.0, 3771.358868992278, 3779.149691319445, 3805.2009078093356, 3806.2958352704563, 3813.199228162089, 3370.9157271068175, 3375.4261775498226, 3386.9491957620407, 3387.5765529308837, 3402.625711171769, 4510.684252102355, 4706.952930470686, 4747.098051370229, 4755.144074066667, 4758.286257061434, 4240.830366785325, 4270.338097594878, 4319.287317592593, 4330.242207613655, 4336.588024137702, 5094.286799848024, 5102.311187989611, 5108.463611320795, 5127.333446651912, 5128.358955130609, 3510.262844802569, 3589.77947497852, 3600.279944011208, 3602.873899413508, 3604.4593311003296, 5233.0, 5302.310699609065, 5316.0, 5323.121684922022, 5336.3329583802415, 3634.3639863024396, 3656.9817150914073, 3658.2683463307444, 3667.7982710951155, 3675.9448608270895, 3711.3690672585726, 3722.553293604785, 3723.1250656095795, 3737.6075512070843, 3740.775553466801, 4088.529819070845, 4260.0, 4265.594768496988, 4310.439642846472, 4312.633426158749, 5032.119379108642, 5043.218301163325, 5044.949550504448, 5052.873678158076, 5059.709774007678, 1201.8317435558854, 1260.6407173955379, 1277.6678063703505, 1280.7886698694797, 1302.6482849630547, 861.7199410191713, 864.4683519635379, 882.1927935938544, 884.2174675412178, 889.3952112563519, 4329.177456283296, 4344.348347747863, 4348.7390756554705, 4353.6299414549485, 4360.345948107809, 5148.819791307361, 5164.8192313268855, 5170.793168273227, 5184.248283998799, 5193.4027586828, 4305.225059489259, 4320.487829259734, 4348.391225228471, 4348.7390756554705, 4357.0, 2330.7203135623495, 2424.1273141668985, 2447.926562203101, 2467.469494058786, 2482.6524286599893, 4305.569443055732, 4321.632661223768, 4321.978390108092, 4373.671974601918, 4376.737395756201, 4656.674032817738, 4698.600618947359, 4711.528847115261, 4720.433547974265, 4733.443940272284, 4072.714909956334, 4277.935830962538, 4344.847930322424, 4370.519242883344, 4373.343998400265, 4525.253333200117, 4553.521880202531, 4555.020670555714, 4580.496145423934, 4649.139909116824, 4486.304622783474, 4502.887427814331, 4505.6395488360195, 4543.727376357429, 4544.204764166324, 4021.436998820109, 4305.720128191658, 4312.245357062564, 4322.5677432256525, 4341.3487976803735, 3388.881389151368, 3390.71178949792, 3410.795352278871, 3427.7771944823508, 3432.056184549269, 4692.507286734844, 4706.529347065266, 4762.9523704762505, 4771.976140119277, 5032.62255330859, 4953.380827396575, 5016.623753218596, 5062.443131255633, 5068.352785344704, 5069.403138011515, 5043.839916819079, 5049.873753156054, 5072.5688316493515, 5077.720725360141, 5082.567981721447, 4869.537393947569, 4982.451930287593, 5006.498050584883, 5018.949810501848, 5034.798608055637, 5056.014077255047, 5058.949410505995, 5061.190209566452, 5074.264231686311, 5077.060743762416, 4952.925706114484, 4958.057968986025, 4991.57571606403, 4992.15133427311, 5014.097462456647], "value": 3706.786153012734, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [674.2448457727345, 690.2683155854794, 700.2717174138896, 738.7488253993641, 779.438804061076, 12478.25130492171, 12510.374481275934, 13716.725665486696, 13722.725545489084, 13736.313184340794, 12727.872721272784, 12865.16376435531, 12865.678358041054, 12941.805872911913, 12972.351382430888, 628.4689437425368, 777.9299863012328, 796.1958421993799, 798.9680412783482, 799.448380617375, 645.4449173710605, 646.0728854094366, 653.4413076819322, 653.7352372289231, 770.3836930455641, 830.6054624053587, 839.3872473094644, 839.8488272111048, 840.0968958369747, 840.794005468661, 835.2274146414572, 837.9874301885477, 838.0153319849214, 838.1241602525375, 838.4508147163617, 477.43900916423064, 591.1871177131444, 602.5601311042964, 613.9938600613981, 614.6066517428804, 13226.404811783397, 13254.138480998801, 13283.468661253539, 13294.534691285759, 13321.400536975763, 12614.117011809178, 12868.87131128686, 13047.934760326138, 13132.277724725136, 13518.797218041638, 12032.39838008105, 12083.758324833454, 12103.455344509519, 12136.514539418413, 12403.13178077535, 4108.91782164358, 4155.646770024551, 4189.601987811153, 4206.600372964564, 4240.321548552217, 60104.0, 60194.398056019316, 60224.0, 60267.0, 60415.0, 10188.0, 10248.38509689406, 10503.107235885036, 10794.56821727122, 10841.83737243942, 19274.22903083861, 19366.70949935752, 19381.03094845252, 19405.32081377145, 19425.222991080198, 6985.476089293324, 7039.788806335818, 7098.929010709827, 7123.821904452327, 7139.428845692332, 3565.625609310985, 3601.081724160322, 3616.0959760059986, 3624.8550057997386, 3629.6551827576336, 2902.796804223726, 2966.9258268543026, 2989.536621823621, 2995.266159790865, 3009.879604815783, 473.96919200251875, 474.6321600759439, 478.09878379255355, 497.24915377779814, 497.6566169343142, 482.9396325459318, 491.8991606720614, 513.7636687123965, 519.4675457655858, 531.5614617940215, 7483.203721635955, 7548.4716069874585, 7692.884606730903, 7703.383729301642, 7718.691252349955, 507.79434329096773, 516.633190434788, 527.5146864884316, 530.3900514408462, 556.2851735519838, 3479.59984601774, 3715.684166845794, 3721.813909304524, 3724.1248306647917, 3750.6249375062275, 68376.0, 94970.52514737382, 96405.0, 96485.51757241169, 96637.51681241549, 49302.26046609304, 55392.72303638456, 87022.56488717643, 88110.55944720235, 88533.55733221292, 75280.0, 75490.62254688801, 75571.0, 75652.24347756561, 76956.0, 6673.9666301668185, 7100.396466300423, 7179.461540384387, 7180.0, 7268.236835132235, 31680.5247921286, 43672.0, 44583.10833783371, 44606.0, 45443.7727811372, 36252.09369765777, 37282.81358593189, 37393.439098413, 58171.41828581829, 61746.38253617586, 9143.817123657622, 9264.53677316118, 9288.767780805534, 9389.24886009104, 9466.810663786548, 9706.320557560903, 9884.950575247078, 9894.505274736379, 10056.497175141067, 10240.180785537288, 9053.818923621622, 9276.397034193025, 9514.001029891762, 9608.13526782565, 9719.125278724949, 9208.3093767969, 9209.539523023956, 9216.861747073934, 9344.299177561574, 9612.66355677548, 8252.917470825216, 8257.876131857907, 8278.296344810758, 8289.0, 8424.62089205975, 7795.610219489116, 7808.258215469521, 7828.882566761617, 7832.337005418185, 8144.633491492778, 6932.445404367538, 7135.964320178574, 7231.240719724564, 7266.309700578437, 7301.853962920605], "value": 6114.735371740724, "unit": "score"}], "name": "dromaeo_css", "value": 6285.076580271293, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 114.0, 115.0, 114.0, 116.0, 112.0, 113.0, 114.0, 113.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 122.0, 129.0, 175.0, 121.0, 146.0, 157.0, 124.0, 204.0, 128.0], "value": 145.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 161.0, 161.0, 159.0, 160.0, 161.0, 162.0, 161.0, 161.0, 160.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 101.0, 76.0, 76.0, 75.0, 75.0, 99.0, 74.0], "value": 80.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 118.0, 85.0, 84.0, 84.0, 126.0, 84.0, 85.0, 117.0], "value": 95.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 65.0, 64.0, 65.0, 65.0, 64.0, 65.0, 65.0], "value": 64.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 65.0], "value": 64.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 79.0, 80.0, 77.0, 78.0, 84.0, 77.0, 79.0, 79.0, 83.0], "value": 79.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 127.0, 138.0, 129.0, 130.0, 126.0, 138.0, 129.0, 203.0, 136.0], "value": 138.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 167.0, 163.0, 168.0, 164.0, 164.0, 172.0, 167.0, 162.0, 162.0], "value": 165.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 66.0, 69.0, 66.0, 66.0, 67.0, 65.0, 66.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1532.8, "alertThreshold": 2.0}]} 15:07:44 INFO - Return code: 0 15:07:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:07:44 INFO - # TBPL SUCCESS # 15:07:44 INFO - Running post-action listener: _resource_record_post_action 15:07:44 INFO - ##### 15:07:44 INFO - ##### Finished run-tests step (success) 15:07:44 INFO - ##### 15:07:44 INFO - Running post-run listener: _resource_record_post_run 15:07:44 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 12288; Write bytes: 535334912; Read time: 132; Write time: 468740 15:07:44 INFO - TinderboxPrint: CPU usage
13.0% 15:07:44 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 132 15:07:44 INFO - TinderboxPrint: I/O write bytes / time
535,334,912 / 468,740 15:07:44 INFO - TinderboxPrint: CPU idle
8,323.7 (87.0%) 15:07:44 INFO - TinderboxPrint: CPU user
1,205.3 (12.6%) 15:07:44 INFO - TinderboxPrint: Swap in / out
0 / 0 15:07:44 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 245624832; Read time: 0; Write time: 251968 15:07:44 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 8192; Write bytes: 289427456; Read time: 124; Write time: 216744 15:07:44 INFO - Running post-run listener: _upload_blobber_files 15:07:44 INFO - Blob upload gear active. 15:07:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:07:44 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 15:07:44 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'] 15:07:44 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 15:07:45 INFO - (blobuploader) - INFO - Open directory for files ... 15:07:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:07:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:07:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:07:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:07:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:07:48 INFO - (blobuploader) - INFO - Done attempting. 15:07:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:07:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:07:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:07:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:07:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:07:49 INFO - (blobuploader) - INFO - Done attempting. 15:07:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:07:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:07:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:07:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:07:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:07:50 INFO - (blobuploader) - INFO - Done attempting. 15:07:50 INFO - (blobuploader) - INFO - Iteration through files over. 15:07:50 INFO - Return code: 0 15:07:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:07:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:07:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a50c7d8de9d88d59e325614dc3f27ca4952b3db7ea3aafb488ddf5592ac04ab2f6fec8f7615d7cc8756cec31d8195e498251956bbc1cbd02f48f3beea63a0aad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7d3ccee7da578ff87c51c4f17e092af533222388c39a8238437ecf4e4ee2ddcf5b8d6558721aee78c011a7398bfeb6b95f91bb01699101b2acb12753e74cd53b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ab1c437db8897606281eec04d1a7db0be8007ac91e4836dccf48b7a18e6baa2cc800794fa4307c9537f40fa16f477e21a685e70083c42e7fead7fee4fc45fe0a"} 15:07:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:07:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:07:50 INFO - Contents: 15:07:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a50c7d8de9d88d59e325614dc3f27ca4952b3db7ea3aafb488ddf5592ac04ab2f6fec8f7615d7cc8756cec31d8195e498251956bbc1cbd02f48f3beea63a0aad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7d3ccee7da578ff87c51c4f17e092af533222388c39a8238437ecf4e4ee2ddcf5b8d6558721aee78c011a7398bfeb6b95f91bb01699101b2acb12753e74cd53b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ab1c437db8897606281eec04d1a7db0be8007ac91e4836dccf48b7a18e6baa2cc800794fa4307c9537f40fa16f477e21a685e70083c42e7fead7fee4fc45fe0a"} 15:07:50 INFO - Running post-run listener: copy_logs_to_upload_dir 15:07:50 INFO - Copying logs to upload dir... 15:07:50 INFO - mkdir: /builds/slave/test/build/upload/logs 15:07:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.265111 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-07-07 15:07:50.135300) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 15:07:50.138948) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1467927894.647237-886956406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a50c7d8de9d88d59e325614dc3f27ca4952b3db7ea3aafb488ddf5592ac04ab2f6fec8f7615d7cc8756cec31d8195e498251956bbc1cbd02f48f3beea63a0aad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7d3ccee7da578ff87c51c4f17e092af533222388c39a8238437ecf4e4ee2ddcf5b8d6558721aee78c011a7398bfeb6b95f91bb01699101b2acb12753e74cd53b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ab1c437db8897606281eec04d1a7db0be8007ac91e4836dccf48b7a18e6baa2cc800794fa4307c9537f40fa16f477e21a685e70083c42e7fead7fee4fc45fe0a"} build_url:https://queue.taskcluster.net/v1/task/HNoQlJIDSyyBmBr4sU32aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011198 build_url: 'https://queue.taskcluster.net/v1/task/HNoQlJIDSyyBmBr4sU32aw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a50c7d8de9d88d59e325614dc3f27ca4952b3db7ea3aafb488ddf5592ac04ab2f6fec8f7615d7cc8756cec31d8195e498251956bbc1cbd02f48f3beea63a0aad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7d3ccee7da578ff87c51c4f17e092af533222388c39a8238437ecf4e4ee2ddcf5b8d6558721aee78c011a7398bfeb6b95f91bb01699101b2acb12753e74cd53b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ab1c437db8897606281eec04d1a7db0be8007ac91e4836dccf48b7a18e6baa2cc800794fa4307c9537f40fa16f477e21a685e70083c42e7fead7fee4fc45fe0a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 15:07:50.164805) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 15:07:50.165148) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1467927894.647237-886956406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004461 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 15:07:50.247432) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 15:07:50.247847) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 15:07:50.248164) ========= ========= Total master_lag: 0.17 =========